origin-7b8b7b9b7-tzgm8 / origin

Starting Pelican...Running pelican-server with arguments: origin servetime="2026-08-06T01:32:06Z" level=info msg="Version: 7.27.0-rc.1"time="2026-08-06T01:32:06Z" level=info msg="Build Date: 2026-07-29T22:06:12Z"time="2026-08-06T01:32:06Z" level=info msg="Build Commit: 78ce679bbdef6322d31b6bec2fcc83f1d3b27c15"time="2026-08-06T01:32:06Z" level=info msg="Configuration constructed according to directory-scoped lexicographical file order from the following directories: /etc/pelican/config.d"time="2026-08-06T01:32:06Z" level=info msg="Interpreting watermark value 85 for config param 'Cache.LowWaterMark' as a percentage."time="2026-08-06T01:32:06Z" level=info msg="Interpreting watermark value 89 for config param 'Cache.HighWaterMark' as a percentage."level=info msg================= Pelican Configuration ================Cache:    AllowedFederations: []    BlocksToPrefetch: 0    ClientStatisticsLocation: /run/pelican/xrootd/cache/xrootd.stats    Concurrency: 0    ConcurrencyDegradedThreshold: 90    DataLocation: ""    DataLocations:        - /run/pelican/cache/data    DataScanMode: all    DataScanResampleInterval: 100    DbLocation: /var/lib/pelican/cache.sqlite    DefaultCacheTimeout: 9.5s    DirectorTest: true    DisableClientX509: true    EnableBroker: true    EnableChaosAPI: false    EnableEvictionMonitoring: true    EnableLotman: false    EnableOIDC: false    EnablePrefetch: true    EnableSiteLocalMode: false    EnableTLSClientAuth: false    EnableV2: false    EnableVoms: false    EvictionMonitoringInterval: 1m0s    EvictionMonitoringMaxDepth: 1    ExportLocation: /    FedTokenLocation: /etc/pelican/cache-fed-token    FilesBaseSize: ""    FilesMaxSize: ""    FilesNominalSize: ""    HighWaterMark: "89"    LocalRoot: ""    LowWaterMark: "85"    MemoryCacheSize: "0"    MetaLocations:        - /run/pelican/cache/meta    MinDirectorRefreshInterval: 15s    NamespaceLocation: /run/pelican/cache/namespace    PSSOrigin: ""    PermittedNamespaces: []    Port: 8442    RunLocation: /run/pelican/xrootd/cache    SelfTest: true    SelfTestInterval: 15s    SelfTestMaxAge: 1h0m0s    SentinelLocation: ""    StorageLocation: /run/pelican/cache    Url: https://origin:8442    WorkerCount: 100    XRootDPrefix: cacheClient:    AssumeDirectorServerHeader: false    CredentialFile: ""    DirectorRetries: 5    DisableHttpProxy: false    DisableProxyFallback: false    EnableOverwrites: false    IsPlugin: false    MaximumDownloadSpeed: 0    MinimumDownloadSpeed: 102400    PreferredCaches: []    SlowTransferRampupTime: 1m40s    SlowTransferWindow: 30s    StoppedTransferTimeout: 1m40s    WorkerCount: 5ClientAgent:    DbLocation: ""    HistoryRetentionDays: 30    IdleTimeout: 10m0s    MaxConcurrentJobs: 5    PidFile: ""    ProgressUpdateInterval: 5s    Socket: ""ConfigBase: /etc/pelicanConfigLocations:    - /etc/pelican/config.dDebug: falseDirector:    AdaptiveSortEWMATimeConstant: 5m0s    AdaptiveSortTruncateConstant: 6    AdvertiseUrl: https://origin:8444    AdvertisementTTL: 15m0s    AssumePresenceAtSingleOrigin: true    CachePresenceCapacity: 2000    CachePresenceTTL: 1m0s    CacheResponseHostnames: []    CacheSortMethod: distance    CachesPullFromCaches: false    CheckCachePresence: true    CheckOriginPresence: true    DbLocation: /var/lib/pelican/director.sqlite    DefaultResponse: cache    EnableBroker: true    EnableFederationMetadataHosting: true    EnableOIDC: false    EnableStat: false    FedTokenLifetime: 15m0s    FilterCachesInErrorState: true    FilteredServers: []    GeoIPLocation: /var/cache/pelican/maxmind/GeoLite2-City.mmdb    MaxMindKeyFile: ""    MaxStatResponse: 1    MetadataComparisonInterval: 10m0s    MinStatResponse: 1    OriginCacheHealthTestInterval: 15s    OriginResponseHostnames: []    RegistryQueryInterval: 1m0s    StatConcurrencyLimit: 100    StatTimeout: 2s    SupportContactEmail: ""    SupportContactUrl: ""DisableHttpProxy: falseDisableProxyFallback: falseFederation:    BrokerUrl: ""    DirectorUrl: https://director:8444    DiscoveryUrl: https://director:8444    JwkUrl: ""    RegistryUrl: https://registry:8444    TopologyDowntimeUrl: ""    TopologyNamespaceUrl: ""    TopologyReloadInterval: 0s    TopologyUrl: ""GeoIPOverrides: nullGeoLocation: ""Issuer:    AccessTokenLifetime: 1h0m0s    AuthenticationSource: OIDC    AuthorizationCodeLifetime: 10m0s    AuthorizationTemplates:        - actions:            - read            - create            - modify          prefix: /data    DynamicClientStaleTimeout: 336h0m0s    DynamicClientUnusedTimeout: 1h0m0s    GroupFile: ""    GroupRequirements: []    GroupSource: ""    IDTokenLifetime: 1h0m0s    IssuerClaimValue: https://origin:8444    OIDCAuthenticationRequirements: null    OIDCAuthenticationUserClaim: sub    OIDCGroupClaim: groups    OIDCIssuerClaim: iss    OIDCPreferClaimsFromIDToken: false    OIDCSubjectClaim: sub    PublicClientID: pelican-public-client    QDLLocation: /opt/qdl    RedirectUris: []    RefreshTokenGracePeriod: 5m0s    RefreshTokenLifetime: 168h0m0s    ScitokensServerLocation: /opt/scitokens-server    TomcatLocation: /opt/tomcat    UserStripDomain: falseIssuerKey: /etc/pelican/issuer.jwkIssuerKeysDirectory: /etc/pelican/issuer-keysLocalCache:    ChunkSize: 512MB    DataLocation: /run/pelican/localcache/cache    DefaultMaxAge: 24h0m0s    FDCacheSize: 500    HighWaterMarkPercentage: 89    LowWaterMarkPercentage: 85    MaxConcurrentPrefetch: 5    MemoryCacheSize: "0"    PrefetchTimeout: 10s    RevalidationJitter: 10    RunLocation: /run/pelican/localcache    Size: "0"    Socket: /run/pelican/localcache/cache.sock    StorageDirs: nullLogging:    Cache:        Http: error        Lotman: error        Ofs: error        Pfc: info        Pss: error        PssSetOpt: error        Scitokens: fatal        Xrd: error        Xrootd: error    Client:        DisableProgressBars: false        ProgressInterval: 1m0s    DisableProgressBars: false    Level: info    LogLocation: ""    Origin:        Cms: error        Http: error        Ofs: error        Oss: error        Scitokens: fatal        Xrd: error        Xrootd: infoLotman:    DbLocation: ""    DefaultLotDeletionLifetime: 48h0m0s    DefaultLotExpirationLifetime: 24h0m0s    EnableAPI: false    EnabledPolicy: fairshare    GarbageCollectionInterval: 1h0m0s    LibLocation: ""    LotHome: /var/lib/lotman    LotRecordRetention: 1440h0m0s    MaxLotLifetime: 168h0m0s    MinFillerWidth: 0s    PolicyDefinitions:        - DiscoverPrefixes: true          DivideUnallocated: true          MergeLocalWithDiscovered: false          PolicyName: fairshare          PurgeOrder:            - del            - exp            - opp            - ded    RenewalCheckInterval: 1h0m0s    SchedulingHorizon: 48h0m0sMinimumDownloadSpeed: 0Monitoring:    AggregatePrefixes:        - /*    DataLocation: /var/lib/pelican/monitoring/data    DataRetention: 360h0m0s    DataRetentionSize: 0B    EnablePrometheus: true    LabelLimit: 64    LabelNameLengthLimit: 128    LabelValueLengthLimit: 2048    MetricAuthorization: false    PortHigher: 9999    PortLower: 9930    PromQLAuthorization: false    SampleLimit: 200    StorageCriticalThreshold: 97    StorageHealthCheckInterval: 5m0s    StorageWarningThreshold: 92    TokenExpiresIn: 1h0m0s    TokenRefreshInterval: 5m0sOIDC:    AuthorizationEndpoint: https://cilogon.org/authorize    ClientID: ""    ClientIDFile: /etc/pelican/oidc-client-id    ClientRedirectHostname: localhost:8444    ClientSecretFile: /etc/pelican/oidc-client-secret    DeviceAuthEndpoint: https://cilogon.org/oauth2/device_authorization    Issuer: https://cilogon.org    Scopes:        - openid        - email        - profile    TokenEndpoint: https://cilogon.org/oauth2/token    UserInfoEndpoint: https://cilogon.org/oauth2/userinfoOrigin:    CacheControl: ""    Concurrency: 0    ConcurrencyDegradedThreshold: 90    DbLocation: /var/lib/pelican/origin.sqlite    DefaultChecksumTypes:        - crc32c    DirectorTest: true    DisableCopies: false    DisableDirectClients: false    DiskUsageCalculationDelay: 5m0s    DiskUsageCalculationInterval: 24h0m0s    DiskUsageCalculationRateLimit: 1000    EnableAtomicUploads: false    EnableBroker: false    EnableCmsd: true    EnableDirListing: false    EnableDirectReads: true    EnableDiskUsageCalculation: false    EnableFallbackRead: false    EnableIssuer: true    EnableListings: true    EnableMacaroons: false    EnableOIDC: true    EnablePublicReads: true    EnableReads: true    EnableTLSClientAuth: false    EnableVoms: false    EnableWrite: false    EnableWrites: true    ExportVolume: ""    ExportVolumes: []    Exports:        - capabilities:            - PublicReads            - Listings            - DirectReads          federationprefix: /public          issuerurls:            - https://origin:8444          storageprefix: /data        - capabilities:            - Reads            - Writes            - Listings            - DirectReads          federationprefix: /private          issuerurls:            - https://origin:8444          storageprefix: /data    FedTokenLocation: /etc/pelican/origin-fed-token    FederationPrefix: ""    GlobusClientIDFile: ""    GlobusClientSecretFile: ""    GlobusCollectionID: ""    GlobusCollectionName: ""    GlobusConfigLocation: /run/pelican/xrootd/origin/globus    GlobusTransferTokenFile: ""    HttpAuthTokenFile: ""    HttpServiceUrl: ""    IssuerMode: oa4mp    Mode: ""    Multiuser: false    MultiuserMinID: 1000    MultiuserUmask: -1    MultiuserVarlinkSocketPath: /run/systemd/userdb/io.systemd.UserDatabase    NamespacePrefix: ""    Port: 8443    RunLocation: /run/pelican/xrootd/origin    S3AccessKeyfile: ""    S3Bucket: ""    S3Region: ""    S3SecretKeyfile: ""    S3ServiceName: ""    S3ServiceUrl: ""    S3UrlStyle: path    SSH:        AuthMethods:            - publickey            - agent            - keyboard-interactive            - password        AutoAddHostKey: false        ChallengeTimeout: 1m0s        ConnectTimeout: 30s        Host: ""        KeepaliveInterval: 5s        KeepaliveTimeout: 20s        KnownHostsFile: ""        MaxRetries: 5        PasswordFile: ""        PelicanBinaryPath: ""        Port: 22        PrivateKeyFile: ""        PrivateKeyPassphraseFile: ""        ProxyJump: ""        RemotePelicanBinaryDir: ""        RemotePelicanBinaryOverrides: []        SessionEstablishTimeout: 5m0s        TunnelCallback: false        User: ""    ScitokensDefaultUser: ""    ScitokensGroupsClaim: wlcg.groups    ScitokensMapSubject: false    ScitokensNameMapFile: ""    ScitokensRestrictedPaths: []    ScitokensUnauthenticatedUser: nobody    ScitokensUsernameClaim: ""    SelfTest: true    SelfTestInterval: 15s    SelfTestMaxAge: 1h0m0s    StoragePrefix: ""    StorageType: posix    SupportedChecksumTypes: []    TokenAudience: https://origin:8443    TransferRateLimit: 0    UploadTempLocation: /run/pelican/xrootd/origin/in-progress    Url: https://origin:8443    UserMapfileRefreshInterval: 1m0s    XRootDPrefix: origin    XRootServiceUrl: ""Plugin:    DirectorDecisionPercentage: 20    Token: ""Registry:    AdminUsers: []    CustomRegistrationFields: null    DbLocation: /var/lib/pelican/registry.sqlite    EnableOIDC: false    InactiveRegistrationCleanupInterval: 5m0s    InactiveRegistrationTimeout: 20m0s    Institutions: null    InstitutionsUrl: ""    InstitutionsUrlReloadMinutes: 15m0s    RequireCacheApproval: false    RequireKeyChaining: true    RequireOriginApproval: falseRuntimeDir: /run/pelicanServer:    AUPCanonicalURL: ""    AUPFile: ""    AUPLastUpdated: ""    AdLifetime: 10m0s    AdminGroups: []    AdvertisementInterval: 1m0s    AutoEnrollUsernameClaims:        - preferred_username        - email        - sub    CollectionAdminGroups: []    CollectionAdminUsers: []    DatabaseBackup:        Frequency: 24h0m0s        Location: /var/lib/pelican/backups        MaxCount: 10    DbLocation: /var/lib/pelican/pelican.sqlite    DirectorUrls: []    DropPrivileges: false    EnablePKCS11: false    EnablePprof: true    EnableUI: true    ExternalWebUrl: https://origin:8444    GroupInviteLinkExpiration: 168h0m0s    HealthMonitoringPublic: false    Hostname: origin    IssuerHostname: ""    IssuerJwks: ""    IssuerPort: 0    IssuerUrl: ""    Modules: []    NewUserDefaultScopes:        - web_ui.access    RegistrationRetryInterval: 10s    SSRFProtection:        AllowedCIDRs: []        BlockedCIDRs: []        Disabled: false        SkipDefaultBlocks: false    SessionSecretFile: /etc/pelican/session-secret    StartupTimeout: 5m0s    TLSCACertificateDirectory: ""    TLSCACertificateFile: /certs/ca.crt    TLSCAKey: /etc/pelican/certificates/tlsca.key    TLSCertificate: ""    TLSCertificateChain: /certs/tls.crt    TLSKey: /certs/tls.key    TrustedProxies: []    UIActivationCodeFile: /etc/pelican/server-web-activation-code    UIAdminUsers: []    UILoginRateLimit: 1    UIPasswordFile: /etc/pelican/server-web-passwd    UnprivilegedUser: pelican    UserAdminGroups: []    UserAdminUsers: []    WebConfigFile: /etc/pelican/web-config.yaml    WebHost: 0.0.0.0    WebPort: 8444    WebReadOnly: falseShoveler:    AMQPExchange: shoveled-xrd    AMQPTokenLocation: /etc/pelican/shoveler-token    Enable: false    IPMapping: null    MessageQueueProtocol: amqp    OutputDestinations: []    PasswordLocation: ""    PortHigher: 9999    PortLower: 9930    QueueDirectory: /var/spool/pelican/shoveler/queue    StompCert: ""    StompCertKey: ""    StompUsername: ""    Topic: ""    URL: ""    VerifyHeader: falseStagePlugin:    Hook: false    MountPrefix: ""    OriginPrefix: ""    ShadowOriginPrefix: ""TLSSkipVerify: falseTopology:    DisableCacheX509: false    DisableCaches: false    DisableDowntime: false    DisableOriginX509: false    DisableOrigins: falseTransport:    BrokerEndpointCacheTTL: 2m0s    DialerKeepAlive: 30s    DialerTimeout: 10s    ExpectContinueTimeout: 1s    IdleConnTimeout: 1m30s    MaxIdleConns: 30    ResponseHeaderTimeout: 10s    TLSHandshakeTimeout: 15sXrootd:    AuthRefreshInterval: 5m0s    Authfile: /etc/pelican/xrootd/authfile    AutoShutdownEnabled: true    ConfigFile: ""    ConfigUpdateFailureTimeout: 1h0m0s    DetailedMonitoringHost: ""    DetailedMonitoringPort: 9930    EnableLocalMonitoring: true    HttpMaxDelay: 9s    LocalMonitoringHost: ""    LocalMonitoringPort: 0    MacaroonsKeyFile: /etc/pelican/macaroons-secret    ManagerHost: ""    ManagerPort: 1213    MaxStartupWait: 10s    MaxThreads: 20000    Mount: ""    Port: 0    RobotsTxtFile: /etc/pelican/robots.txt    RunLocation: ""    ScitokensConfig: /etc/pelican/xrootd/scitokens.cfg    ShutdownTimeout: 0s    Sitename: origin    SummaryMonitoringHost: ""    SummaryMonitoringPort: 9931============= End of Pelican Configuration ============time="2026-08-06T01:32:06Z" level=info msg="Configuring multi-exports from Origin.Exports block in config file"time="2026-08-06T01:32:06Z" level=warning msg="Storage prefix \"/data\" may lack permissions for export \"/private\": storage prefix \"/data\" for export \"/private\" requires \"write and execute (-wx)\" permissions for the \"xrootd\" user (uid=10940, gid=10940) to support the \"Writes\" capability, but the current permissions are \"-rwxr-xr-x\" (owner uid=1000, gid=997). You may need to adjust the ownership or permissions of the directory so that the XRootD daemon user has the necessary access: invalid origin configuration. The origin will still start, but runtime errors may occur if the XRootD daemon user truly lacks access. This may be a false positive on filesystems that don't store real uid/gid on disk and synthesize ownership at runtime (e.g. FUSE, NFS, etc.)."time="2026-08-06T01:32:06Z" level=info msg="Creating in-progress directory /run/pelican/xrootd/origin/in-progress with mode 1777 (world-writable + sticky bit)"time="2026-08-06T01:32:06Z" level=info msg="OK   20250407154047_api_tokens.sql (990.96µs)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20250407175156_server.sql (1.62ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20250507041205_server_name.sql (911.18µs)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20250729143942_collections.sql (1.96ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20250929190630_add_users_and_groups.sql (1.58ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20251014193721_add_server_id.sql (1ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260220120000_server_master_keys.sql (832.19µs)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260401220000_group_enrollment_management.sql (5.47ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260424180000_add_user_password_hash.sql (1.06ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260425120000_user_soft_delete.sql (1.21ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260425180000_invite_link_kinds.sql (2.89ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260426000000_group_display_name.sql (1.05ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260426060000_creator_audit.sql (3.3ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260426120000_one_identity_per_issuer_per_user.sql (817.93µs)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260426180000_invite_links_nullable_group_id.sql (3.01ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260427120000_invite_link_token_prefix.sql (1.25ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260428120000_aup_documents.sql (1.28ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260428180000_user_group_scopes.sql (1.6ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260429000000_collection_owner_admin.sql (2.2ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260430000000_invite_links_collection_ownership.sql (1.25ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260430120000_groups_created_for_collection.sql (1.14ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260502152700_rename_server_web_admin_scope.sql (738µs)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260502164824_collection_enable_sharing.sql (1.24ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260502165710_collection_parent_id.sql (1.37ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260502172201_group_auth_template_eligible.sql (1.23ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260503120000_partial_user_unique_indexes.sql (1.16ms)\n"time="2026-08-06T01:32:06Z" level=info msg="goose: successfully migrated database to version: 20260503120000\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20251111180645_create_globus_table.sql (945.87µs)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260219120000_create_embedded_oidc_tables.sql (4.76ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260308120000_add_registration_access_token.sql (2.28ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260313120000_add_namespace_to_oidc_tables.sql (6.13ms)\n"time="2026-08-06T01:32:06Z" level=info msg="OK   20260401120000_oidc_clients_composite_pk.sql (3.37ms)\n"time="2026-08-06T01:32:06Z" level=info msg="goose: successfully migrated database to version: 20260401120000\n"time="2026-08-06T01:32:06Z" level=error msg="SELECT * FROM `users` WHERE (username = \"admin\" AND issuer = \"https://origin:8444\") AND `users`.`deleted_at` IS NULL ORDER BY `users`.`id` LIMIT 1" component=gorm duration="349.86µs" error="record not found" rows=0time="2026-08-06T01:32:06Z" level=error msg="SELECT * FROM `counters` WHERE key = \"new_user_default_scopes_backfill_v1\" ORDER BY `counters`.`key` LIMIT 1" component=gorm duration="84.427µs" error="record not found" rows=0time="2026-08-06T01:32:06Z" level=info msg="NewUserDefaultScopes backfill: granted 1 scope rows across 1 users"time="2026-08-06T01:32:08Z" level=info msg="Will launch daemon \"xrootd.origin\" with UID 10940 and GID 10940"time="2026-08-06T01:32:08Z" level=info msg="Successfully launched xrootd.origin"time="2026-08-06T01:32:08Z" level=info msg="Will launch daemon \"oa4mp\" with UID 10443 and GID 10443"time="2026-08-06T01:32:08Z" level=info msg="Successfully launched oa4mp"time="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 Starting on Linux 6.8.0-1062-azure" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 xrootd -s /run/pelican/xrootd/origin/xrootd.pid -c /run/pelican/xrootd/origin/xrootd.cfg -n origin" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Copr.  2004-2012 Stanford University, xrd version v5.9.6" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config warning: this hostname, origin-7b8b7b9b7-tzgm8, is registered without a domain qualification." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ xrootd origin@origin-7b8b7b9b7-tzgm8 initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config using configuration file /run/pelican/xrootd/origin/xrootd.cfg" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.port 8443" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.protocol http:8443 libXrdHttp.so " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.tls /run/pelican/xrootd/origin/copied-tls-creds.crt /run/pelican/xrootd/origin/copied-tls-creds.crt" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.tlsca certfile /run/pelican/xrootd/origin/ca-bundle.crt" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.sitename origin" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.report 127.0.0.1:9930 every 30s" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.adminpath /run/pelican/xrootd/origin" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.pidpath /run/pelican/xrootd/origin" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.sched maxt 20000" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.trace -all" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrd.network nodnr" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ xrootd origin@origin-7b8b7b9b7-tzgm8 TLS initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="NOTE: Picked up JDK_JAVA_OPTIONS:  --add-opens=java.base/java.lang=ALL-UNNAMED --add-opens=java.base/java.lang.invoke=ALL-UNNAMED --add-opens=java.base/java.lang.reflect=ALL-UNNAMED --add-opens=java.base/java.io=ALL-UNNAMED --add-opens=java.base/java.util=ALL-UNNAMED --add-opens=java.base/java.util.concurrent=ALL-UNNAMED --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="------ xrootd origin@origin-7b8b7b9b7-tzgm8 TLS initialization ended." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config maximum number of connections restricted to 1048576" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Plugin loaded xrdhttp v5.9.6 from protocol libXrdHttp-5.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Copr.  2012 Stanford University, xroot protocol 5.1.0 version v5.9.6" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ xroot protocol initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.monitor all auth flush 30s window 5s fstat 60 lfn ops xfr 5 dest redir fstat info files user pfc tcpmon ccm throttle 127.0.0.1:9930" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.mongstream oss throttle use send json dflthdr 127.0.0.1:9930" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.seclib libXrdSec.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.export /public" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.export /private" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.export /pelican/monitoring" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.export /.well-known" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.fslib ++ throttle" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.chksum max 10 md5 adler32 crc32 crc32c" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.trace emsg login stall redirect" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> xrootd.tls all" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config exporting /public" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config exporting /private" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config exporting /.well-known" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config exporting /pelican/monitoring" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Plugin loaded secprot v5.9.6 from seclib libXrdSec-5.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ Authentication system initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> sec.protbind * none" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config 1 authentication directives processed in /run/pelican/xrootd/origin/xrootd.cfg" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ Authentication system initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ Protection system initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config warning: Security level is set to none; request protection disabled!" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config Local  protection level: none" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config Remote protection level: none" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ Protection system initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config Routing for 10.244.0.5: local pub4 prv4 " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config Route all4: 10.244.0.5 Dest=[::10.244.0.5]:8443" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ File system initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.role server" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> ofs.osslib ++ libXrdOssStats.so " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> ofs.authlib ++ libXrdAccSciTokens.so config=/run/pelican/xrootd/origin/scitokens-origin-generated.cfg " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> ofs.trace -all" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ Storage system initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> oss.localroot /run/pelican/xrootd/origin/export " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.export /public" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.export /private" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config warning: ignoring invalid trace option 'error'." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> oss.trace error" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config effective /run/pelican/xrootd/origin/xrootd.cfg oss configuration:" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.alloc        0 0 0" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.spacescan    600" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.fdlimit      524288 1048576" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.maxsize      0" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.localroot /run/pelican/xrootd/origin/export" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.trace        0" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.xfr          1 deny 10800 keep 1200" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.memfile off  max 8383909888" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.defaults  r/w nocheck nodread nomig nopurge norcreate nostage" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.path /private r/w nocheck nodread nomig nopurge norcreate nostage" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       oss.path /public r/w nocheck nodread nomig nopurge norcreate nostage" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ Storage system initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Plugin loaded fsstats v5.9.6 from osslib libXrdOssStats-5.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ Initializing the storage statistics plugin." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 fsstat_Config: Logging levels enabled warning, error" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="ConfigStats monitoring has been configured via xrootd.mongstream directive" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ Authorization system initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 acc_Config: Authorization system using configuration in /run/pelican/xrootd/origin/xrootd.cfg" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> acc.audit deny grant" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> acc.authdb /run/pelican/xrootd/origin/authfile-origin-generated" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> acc.authrefresh 300" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config 3 authorization directives processed in /run/pelican/xrootd/origin/xrootd.cfg" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config 1 auth entries processed in /run/pelican/xrootd/origin/authfile-origin-generated" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ Authorization system initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Plugin loaded XrdAccSciTokens v5.9.6 from authlib libXrdAccSciTokens-5.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ XrdAccSciTokens: Initialized SciTokens-based authorization." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> scitokens.trace none " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 scitokens_Config: Logging levels enabled -" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ Configuring server role. . ." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> all.adminpath /run/pelican/xrootd/origin" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> cms.trace -all" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ Checkpoint initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ Checkpoint initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config effective /run/pelican/xrootd/origin/xrootd.cfg ofs configuration:" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       all.role server" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.authorize" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.maxdelay   60" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.persist    manual hold 600 logdir /run/pelican/xrootd/origin/origin/.ofs/posc.log" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.trace      0" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.authlib default " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.authlib ++ libXrdAccSciTokens.so config=/run/pelican/xrootd/origin/scitokens-origin-generated.cfg" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.osslib default " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="       ofs.osslib ++ libXrdOssStats.so " daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ File system server initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Initializing a Throttled file system." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="ConfigThrottle g-stream has been configured via xrootd.mongstream directive" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config asynchronous I/O has been disabled!" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ xroot protocol initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Copr. 2012 CERN IT, an HTTP implementation for the XRootD framework." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ HTTP protocol initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.tlsclientauth off" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.header2cgi Authorization authz" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticpreload http://static/robots.txt /run/pelican/xrootd/origin/robots.txt" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.exthandler xrdpelican libXrdHttpPelican.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 sysconfig: invalid trace option none" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.trace none" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.maxdelay 9" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.exthandler xrdtpc libXrdHttpTPC.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=OPTIONS Access-Control-Allow-Origin *" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=OPTIONS Access-Control-Allow-Methods GET,PUT,PROPFIND" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=OPTIONS Access-Control-Allow-Headers Authorization,Want-Digest,Content-Type,User-Agent,Depth,Content-Length,Translate" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=GET Access-Control-Allow-Origin *" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=GET Access-Control-Allow-Headers Authorization,Want-Digest,Content-Type,User-Agent" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=PUT Access-Control-Allow-Origin *" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=PUT Access-Control-Allow-Headers Authorization" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=PROPFIND Access-Control-Allow-Origin *" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="=====> http.staticheader -verb=PROPFIND Access-Control-Allow-Headers Depth,Content-Type,Authorization,Content-Length,Translate" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config Using xrd.tls to supply 'cert' and 'key'." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Config Using xrd.tlsca to supply 'cafile'." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="++++++ HTTPS initialization started." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ HTTPS initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Plugin loaded XrdHttpPelican v5.9.1 from exthandlerlib libXrdHttpPelican-5.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: Will load configuration for the Pelican handler from /run/pelican/xrootd/origin/xrootd.cfg" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: Signal handlers installed for crash reporting" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: Executable path saved for re-exec: /usr/bin/xrootd" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: XRDHTTP_PELICAN_CA_FILE environment variable not set; cannot update the CAs" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: XRDHTTP_PELICAN_CERT_FILE environment variable not set; cannot update the host certificate" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: XRDHTTP_PELICAN_CACHE_SELF_TEST_FILE environment variable not set; cannot pass a cache self-test file" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: XRDHTTP_PELICAN_CACHE_SELF_TEST_FILE_CINFO environment variable not set; cannot pass a cache self-test file cinfo" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: XRDHTTP_PELICAN_AUTHFILE_GENERATED environment variable not set; cannot update the authfile" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: XRDHTTP_PELICAN_SCITOKENS_GENERATED environment variable not set; cannot update the SciTokens" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 pelican_PelicanHandler: XRDHTTP_PELICAN_FEDTOKEN environment variable not set; cannot update the federation token" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Plugin loaded HttpTPC v5.9.6 from exthandlerlib libXrdHttpTPC-5.so" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 sysTPCInitialize: Will load configuration for the TPC handler from /run/pelican/xrootd/origin/xrootd.cfg" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 TPC_Config: Using filesystem object from the framework." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 sysConfig: XRDROLE:  server" daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="260806 01:32:08 046 sysConfig: Configured as HTTP(s) data server." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ HTTP protocol initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="------ xrootd origin@origin-7b8b7b9b7-tzgm8:8443 initialization completed." daemon=xrootd.origintime="2026-08-06T01:32:08Z" level=info msg="Origin startup complete on port 8443"time="2026-08-06T01:32:08Z" level=info msg="No existing database backups found; creating one now"time="2026-08-06T01:32:08Z" level=info msg="Starting periodic database backup every 24h0m0s"time="2026-08-06T01:32:08Z" level=info msg="Starting web engine..."time="2026-08-06T01:32:08Z" level=info msg="Database backup created: /var/lib/pelican/backups/pelican-db-backup-2026-08-06T013208.bak"time="2026-08-06T01:32:08Z" level=info msg="Failed to send request to Web UI at https://origin:8444/api/v1.0/health; likely server is not up (will retry in 50ms): Get \"https://origin:8444/api/v1.0/health\": dial tcp 10.99.176.186:8444: connect: connection refused"time="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.799 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name:   Apache Tomcat/9.0.115" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.805 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built:          Jan 21 2026 08:17:26 UTC" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.805 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 9.0.115.0" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.805 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name:               Linux" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.805 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version:            6.8.0-1062-azure" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.806 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture:          amd64" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.806 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home:             /usr/lib/jvm/java-17-openjdk-17.0.20.0.8-1.2.el9.alma.1.x86_64" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.806 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version:           17.0.20+8-LTS" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.806 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor:            Red Hat, Inc." daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.806 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE:         /opt/tomcat" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.806 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME:         /opt/tomcat" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.817 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.817 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang.invoke=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.818 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang.reflect=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.818 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.819 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.819 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util.concurrent=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.819 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.819 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=/opt/tomcat/conf/logging.properties" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.819 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.819 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.awt.headless=true" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.821 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.security.egd=file:/dev/urandom" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.821 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.library.path=/opt/tomcat/lib" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.821 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.822 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.822 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dsun.io.useCanonCaches=false" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.823 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0027" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.823 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Xms512M" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.823 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Xmx1024M" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.823 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:+UseParallelGC" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.823 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs=" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.823 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=/opt/tomcat" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.823 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=/opt/tomcat" daemon=oa4mptime="2026-08-06T01:32:08Z" level=info msg="06-Aug-2026 01:32:08.825 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=/opt/tomcat/temp" daemon=oa4mptime="2026-08-06T01:32:09Z" level=info msg="06-Aug-2026 01:32:09.106 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler [\"http-nio-/opt/scitokens-server/var/http.sock\"]" daemon=oa4mptime="2026-08-06T01:32:09Z" level=info msg="06-Aug-2026 01:32:09.141 INFO [main] org.apache.catalina.startup.Catalina.load Server initialization in [589] milliseconds" daemon=oa4mptime="2026-08-06T01:32:09Z" level=info msg="06-Aug-2026 01:32:09.175 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina]" daemon=oa4mptime="2026-08-06T01:32:09Z" level=info msg="06-Aug-2026 01:32:09.176 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.115]" daemon=oa4mptime="2026-08-06T01:32:09Z" level=info msg="06-Aug-2026 01:32:09.179 SEVERE [main] org.apache.catalina.startup.HostConfig.beforeStart Unable to create directory for deployment: [/opt/tomcat/conf/Catalina/localhost]" daemon=oa4mptime="2026-08-06T01:32:09Z" level=info msg="06-Aug-2026 01:32:09.182 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/opt/tomcat/webapps/scitokens-server]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="06-Aug-2026 01:32:11.248 INFO [main] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Logging to file /dev/stdout" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:OA4MP, version 6.2.3 startup on Thu Aug 06 01:32:11 UTC 2026" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:loading environment..." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:loading configuration." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: setting local consent to true" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:ping enabled" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: Getting scope handler null" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Scope handler attribute found in configuration, but no value was found for it. Skipping custom loaded scope handling." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: No server-wide configured Scope handler" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:No claim source configuration found." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Starting to load LDAP configuration." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace:    LDAP scope handler disabled, creating basic" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace:    Actual scope handler = BasicClaimsSourceImpl" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:loaded JSON web keys from file \"/opt/scitokens-server/etc/keys.jwk\"" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:1.6-QDL-SNAPSHOT startup on Thu Aug 06 01:32:11 UTC 2026" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: RFC 8693 support enabled? true" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: safe garbage collection enabled? false" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: cleanupLockingEnabled set to false" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: cleanupFailOnErrors set to true" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: cleanupInterval set to 3600000" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: admin client notification addresses: null" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: monitorEnable set to false" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: monitorInterval set to 1800000" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: client credential support enabled? true" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Refresh token support enabled" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: Getting scope handler org.oa4mp.server.loader.oauth2.claims.BasicClaimsSourceImpl@293af2f1" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | OA2ConfigurationLoader | trace: Getting scope handler org.oa4mp.server.loader.oauth2.claims.BasicClaimsSourceImpl@293af2f1" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Debugging is on" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:No polling configured." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:done loading environment." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | info: updating store table for DSFSClientStore[dataPath=/opt/scitokens-server/var/storage/file_store/clients/dataPath, indexPath=/opt/scitokens-server/var/storage/file_store/clients/indexPath]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | info: updating store table for PermissionFileStore[dataPath=/opt/scitokens-server/var/storage/file_store/permissions/dataPath, indexPath=/opt/scitokens-server/var/storage/file_store/permissions/indexPath]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | info: updating store table for OA2FSTStore[dataPath=/opt/scitokens-server/var/storage/file_store/transactions/dataPath, indexPath=/opt/scitokens-server/var/storage/file_store/transactions/indexPath]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | info: updating store table for AdminClientFS[dataPath=/opt/scitokens-server/var/storage/file_store/adminClients/dataPath, indexPath=/opt/scitokens-server/var/storage/file_store/adminClients/indexPath]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | info: updating store table for DSFSClientApprovalStore[dataPath=/opt/scitokens-server/var/storage/file_store/clientApprovals/dataPath, indexPath=/opt/scitokens-server/var/storage/file_store/clientApprovals/indexPath]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | info: updating store table for TXFileStore[dataPath=/opt/scitokens-server/var/storage/file_store/txStore/dataPath, indexPath=/opt/scitokens-server/var/storage/file_store/txStore/indexPath]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | info: updating store table for VIFileStore[dataPath=/opt/scitokens-server/var/storage/file_store/voStore/dataPath, indexPath=/opt/scitokens-server/var/storage/file_store/voStore/indexPath]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Cleaning up incomplete client registrations" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="06-Aug-2026 01:32:11.622 INFO [Thread-1] edu.uiuc.ncsa.security.core.util.MyLoggingFacade.info edu.uiuc.ncsa.security.util.pkcs.KeyPairPopulationThread:starting queue populator" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:No error notification subject set. Skipping..." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | trace: setting transaction cleanup interval to 3600000 ms." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Started refresh token cleanup thread with interval 3600000 ms." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:starting cleanup thread for transaction cleanup" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:next cleanup for transaction cleanup scheduled for Thu Aug 06 02:32:11 UTC 2026" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg=" | <origin> | OA2ServletInitializer | trace: setting \"TX record cleanup\" interval to 3600000 ms." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:Starting token exchange record store cleanup thread with interval 3600000 ms." daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:starting cleanup thread for TX record cleanup" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="Aug 06, 2026 1:32:11 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="INFO: oa4mp:next cleanup for TX record cleanup scheduled for Thu Aug 06 02:32:11 UTC 2026" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="06-Aug-2026 01:32:11.649 INFO [main] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/opt/tomcat/webapps/scitokens-server] has finished in [2,466] ms" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="06-Aug-2026 01:32:11.652 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler [\"http-nio-/opt/scitokens-server/var/http.sock\"]" daemon=oa4mptime="2026-08-06T01:32:11Z" level=info msg="06-Aug-2026 01:32:11.661 INFO [main] org.apache.catalina.startup.Catalina.start Server startup in [2520] milliseconds" daemon=oa4mptime="2026-08-06T01:32:22Z" level=warning msg="Self-test monitoring cycle failed:  test file transfer failed during upload: failed to upload test file: failed to start request for test file upload: Put \"https://origin:8443/pelican/monitoring/selfTest/self-test-2026-08-06T01:32:12Z.txt\": dial tcp 10.99.176.186:8443: i/o timeout"time="2026-08-06T01:32:24Z" level=warning msg="Self-test monitoring cycle failed:  test file transfer failed during upload: failed to upload test file: failed to start request for test file upload: Put \"https://origin:8443/pelican/monitoring/selfTest/self-test-2026-08-06T01:32:22Z.txt\": dial tcp 10.99.176.186:8443: connect: connection refused"time="2026-08-06T01:32:36Z" level=warning msg="No director test report received within the time limit"time="2026-08-06T01:32:37Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="47.508µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:32:37Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time="17.092µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:32:37Z" level=info msg="Will advertise to director endpoints: https://director:8444"time="2026-08-06T01:32:37Z" level=info msg="Aug 06, 2026 1:32:37 AM edu.uiuc.ncsa.security.core.util.MyLoggingFacade info" daemon=oa4mptime="2026-08-06T01:32:37Z" level=info msg="INFO: oa4mp:OA2DiscoveryServlet <127.0.0.1>: request ok" daemon=oa4mptime="2026-08-06T01:32:37Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time=143.639345ms method=GET resource=/scitokens-server/.well-known/openid-configuration status=200time="2026-08-06T01:32:37Z" level=info msg="Namespace /origins/origin:8444 not registered; new registration will proceed\n"time="2026-08-06T01:32:37Z" level=info msg="Namespace /public not registered; new registration will proceed\n"time="2026-08-06T01:32:37Z" level=info msg="Namespace /private not registered; new registration will proceed\n"time="2026-08-06T01:32:37Z" level=info msg="Address file written to /run/pelican/pelican.addresses"time="2026-08-06T01:32:37Z" level=info msg="Starting web login..."time="2026-08-06T01:32:37Z" level=info msg="Starting TSDB ..." component=prometheustime="2026-08-06T01:32:37Z" level=info msg="260806 01:32:37 067 XrootdBridge: unknown.1:27@[::10.244.0.7] login as nobody" daemon=xrootd.origintime="2026-08-06T01:32:37Z" level=info msg="Replaying on-disk memory mappable chunks if any" component=tsdbtime="2026-08-06T01:32:37Z" level=info msg="On-disk memory mappable chunks replay completed" component=tsdb duration="1.984µs"time="2026-08-06T01:32:37Z" level=info msg="Replaying WAL, this may take a while" component=tsdbtime="2026-08-06T01:32:37Z" level=info msg="WAL segment loaded" component=tsdb maxSegment=0 segment=0time="2026-08-06T01:32:37Z" level=info msg="WAL replay completed" checkpoint_replay_duration="76.752µs" component=tsdb total_replay_duration="396.455µs" wal_replay_duration="290.358µs" wbl_replay_duration=170nstime="2026-08-06T01:32:37Z" level=info msg="TSDB started" component=prometheustime="2026-08-06T01:32:37Z" level=info msg="Completed loading of configuration" component=prometheus db_storage="1.413µs" query_engine=672ns scrape="87.252µs" scrape_sd="33.713µs" totalDuration="124.941µs"time="2026-08-06T01:32:37Z" level=info msg="Server is ready to receive web requests." component=prometheustime="2026-08-06T01:32:37Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time="912.682µs" method=POST resource=/api/v1.0/origin/directorTest status=200time="2026-08-06T01:32:38Z" level=info msg="260806 01:32:38 068 XrootdBridge: unknown.2:28@[::10.244.0.1] login as nobody" daemon=xrootd.origintime="2026-08-06T01:32:38Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time="60.673µs" method=GET resource=/.well-known/openid-configuration status=200time="2026-08-06T01:32:38Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time="86.751µs" method=GET resource=/.well-known/issuer.jwks status=200time="2026-08-06T01:32:41Z" level=info msg="Served Request" client=10.244.0.6 daemon=gin fields.time="24.436µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:32:49Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="27.742µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:32:52Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="16.711µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:32:52Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time="292.573µs" method=POST resource=/api/v1.0/origin/directorTest status=200time="2026-08-06T01:32:52Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time=3.100016ms method=GET resource=/metrics status=200time="2026-08-06T01:32:58Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time=3.010481ms method=GET resource=/metrics status=200time="2026-08-06T01:33:07Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="24.726µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:33:07Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time="319.843µs" method=POST resource=/api/v1.0/origin/directorTest status=200time="2026-08-06T01:33:07Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time=2.455545ms method=GET resource=/metrics status=200time="2026-08-06T01:33:08Z" level=info msg="260806 01:33:08 081 cms_Finder: Waiting for cms path /run/pelican/xrootd/origin/origin/.olb/olbd.admin" daemon=xrootd.origintime="2026-08-06T01:33:13Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time=3.097596ms method=GET resource=/metrics status=200time="2026-08-06T01:33:19Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="20.118µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:33:22Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="23.854µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:33:22Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time="319.764µs" method=POST resource=/api/v1.0/origin/directorTest status=200time="2026-08-06T01:33:22Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time=2.808446ms method=GET resource=/metrics status=200time="2026-08-06T01:33:28Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time=3.0579ms method=GET resource=/metrics status=200time="2026-08-06T01:33:37Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="23.173µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:33:37Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time="403.408µs" method=POST resource=/api/v1.0/origin/directorTest status=200time="2026-08-06T01:33:37Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time=7.035629ms method=GET resource=/metrics status=200time="2026-08-06T01:33:43Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time=2.973549ms method=GET resource=/metrics status=200time="2026-08-06T01:33:49Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="22.582µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:33:52Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="25.207µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:33:52Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time="361.651µs" method=POST resource=/api/v1.0/origin/directorTest status=200time="2026-08-06T01:33:52Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time=3.783965ms method=GET resource=/metrics status=200time="2026-08-06T01:33:58Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time=2.60041ms method=GET resource=/metrics status=200time="2026-08-06T01:34:07Z" level=info msg="Served Request" client="::1" daemon=gin fields.time="46.957µs" method=GET resource=/api/v1.0/health status=200time="2026-08-06T01:34:07Z" level=info msg="Served Request" client=10.244.0.7 daemon=gin fields.time="341.594µs" method=POST resource=/api/v1.0/origin/directorTest status=200time="2026-08-06T01:34:07Z" level=info msg="Served Request" client=10.244.0.1 daemon=gin fields.time=3.636474ms method=GET resource=/metrics status=200time="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 111 XrootdBridge: unknown.3:29@[::10.244.0.4] login as nobody" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 111 acc_Audit: unknown.3:29@[::10.244.0.4] grant https *@[::ffff:10.244.0.4] read /public/data/0.0" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 193 XrootdBridge: unknown.4:30@[::10.244.0.4] login as nobody" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 193 acc_Audit: unknown.4:30@[::10.244.0.4] grant https *@[::ffff:10.244.0.4] stat /public/data/0.0" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 192 XrootdBridge: unknown.5:31@[::10.244.0.4] login as nobody" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 192 acc_Audit: unknown.5:31@[::10.244.0.4] grant https *@[::ffff:10.244.0.4] stat /public/data/0.0" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 192 acc_Audit: unknown.5:31@[::10.244.0.4] grant https *@[::ffff:10.244.0.4] stat /public/data/0.0" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 192 ofs_FAttr: Unable to get attr XrdCks.md5 from /run/pelican/xrootd/origin/export/public/data/0.0; operation not supported" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 192 ofs_chksum: unknown.5:31@[::10.244.0.4] Unable to checksum /public/data/0.0; operation not supported" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 192 unknown.5:31@[::10.244.0.4] Xrootd_Response: sending err 3013: Unable to checksum /public/data/0.0; operation not supported" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 192 XrootdXeq: unknown.5:31@[::10.244.0.4] disc 0:00:00 (send failure)" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 126 XrootdXeq: unknown.4:30@[::10.244.0.4] disc 0:00:00" daemon=xrootd.origintime="2026-08-06T01:34:08Z" level=info msg="260806 01:34:08 194 XrootdXeq: unknown.3:29@[::10.244.0.4] disc 0:00:00" daemon=xrootd.origin