prole/prole-mssql-db/log/errorlog.5

160 lines
19 KiB
Groff

2025-07-04 19:59:54.56 Server Microsoft SQL Server 2022 (RTM-CU19) (KB5054531) - 16.0.4195.2 (X64)
Apr 18 2025 13:42:14
Copyright (C) 2022 Microsoft Corporation
Developer Edition (64-bit) on Linux (Ubuntu 22.04.5 LTS) <X64>
2025-07-04 19:59:54.56 Server UTC adjustment: 0:00
2025-07-04 19:59:54.56 Server (c) Microsoft Corporation.
2025-07-04 19:59:54.57 Server All rights reserved.
2025-07-04 19:59:54.57 Server Server process ID is 488.
2025-07-04 19:59:54.57 Server Logging SQL Server messages in file '/var/opt/mssql/log/errorlog'.
2025-07-04 19:59:54.57 Server Registry startup parameters:
-d /var/opt/mssql/data/master.mdf
-l /var/opt/mssql/data/mastlog.ldf
-e /var/opt/mssql/log/errorlog
2025-07-04 19:59:54.57 Server SQL Server detected 1 sockets with 10 cores per socket and 10 logical processors per socket, 10 total logical processors; using 10 logical processors based on SQL Server licensing. This is an informational message; no user action is required.
2025-07-04 19:59:54.57 Server SQL Server is starting at normal priority base (=7). This is an informational message only. No user action is required.
2025-07-04 19:59:54.58 Server Detected 6270 MB of RAM, 1402 MB of available memory, 1402 MB of available page file. This is an informational message; no user action is required.
2025-07-04 19:59:54.58 Server Using conventional memory in the memory manager.
2025-07-04 19:59:54.58 Server Detected pause instruction latency: 0 cycles.
2025-07-04 19:59:54.58 Server SQL Server detected the following NUMA node configuration (NUMA Node number 0, Processor Group number 0, CPU Mask 0x00000000000003ff).
2025-07-04 19:59:54.58 Server Page exclusion bitmap is enabled.
2025-07-04 19:59:54.62 Server Buffer pool extension is not supported on Linux platform.
2025-07-04 19:59:54.62 Server Buffer Pool: Allocating 2097152 bytes for 215833 hashPages.
2025-07-04 19:59:54.68 Server Automatic soft-NUMA was enabled because SQL Server has detected hardware NUMA nodes with greater than 8 physical cores.
2025-07-04 19:59:54.80 Server Buffer pool extension is already disabled. No action is necessary.
2025-07-04 19:59:55.29 Server Installing Client TLS certificates to the store.
2025-07-04 19:59:55.30 Server CPU vectorization level(s) detected: SSE SSE2 SSE3 SSSE3 SSE41 SSE42 POPCNT
2025-07-04 19:59:55.43 Server Successfully initialized the TLS configuration. Allowed TLS protocol versions are ['1.0 1.1 1.2']. Allowed TLS ciphers are ['ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-ECDSA-AES128-SHA:AES256-GCM-SHA384:AES128-GCM-SHA256:AES256-SHA256:AES128-SHA256:AES256-SHA:AES128-SHA:!DHE-RSA-AES256-GCM-SHA384:!DHE-RSA-AES128-GCM-SHA256:!DHE-RSA-AES256-SHA:!DHE-RSA-AES128-SHA'].
2025-07-04 19:59:55.54 Server Query Store settings initialized with enabled = 1,
2025-07-04 19:59:55.59 Server The maximum number of dedicated administrator connections for this instance is '1'
2025-07-04 19:59:55.61 Server Node configuration: node 0: CPU mask: 0x000000000000001f:0 Active CPU mask: 0x000000000000001f:0. This message provides a description of the NUMA configuration for this computer. This is an informational message only. No user action is required.
2025-07-04 19:59:55.62 Server Node configuration: node 1: CPU mask: 0x00000000000003e0:0 Active CPU mask: 0x00000000000003e0:0. This message provides a description of the NUMA configuration for this computer. This is an informational message only. No user action is required.
2025-07-04 19:59:55.65 Server Using dynamic lock allocation. Initial allocation of 2500 Lock blocks and 5000 Lock Owner blocks per node. This is an informational message only. No user action is required.
2025-07-04 19:59:55.83 Server In-Memory OLTP initialized on lowend machine.
2025-07-04 19:59:55.89 Server CLR version v4.0.30319 loaded.
2025-07-04 19:59:55.95 Server [INFO] Created Extended Events session 'hkenginexesession'
2025-07-04 19:59:55.96 Server Database Instant File Initialization: enabled. For security and performance considerations see the topic 'Database Instant File Initialization' in SQL Server Books Online. This is an informational message only. No user action is required.
2025-07-04 19:59:55.97 Server Total Log Writer threads: 2. This is an informational message; no user action is required.
2025-07-04 19:59:55.99 Server Software Usage Metrics is disabled.
2025-07-04 19:59:56.03 spid31s [1]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:56.04 spid31s Starting up database 'master'.
2025-07-04 19:59:56.34 spid31s 14 transactions rolled forward in database 'master' (1:0). This is an informational message only. No user action is required.
2025-07-04 19:59:56.43 spid31s 0 transactions rolled back in database 'master' (1:0). This is an informational message only. No user action is required.
2025-07-04 19:59:56.43 spid31s Recovery is writing a checkpoint in database 'master' (1). This is an informational message only. No user action is required.
2025-07-04 19:59:56.62 spid31s [32762]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:56.63 spid31s Starting up database 'model_replicatedmaster'.
2025-07-04 19:59:56.64 spid39s [32767]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:56.64 spid39s Starting up database 'mssqlsystemresource'.
2025-07-04 19:59:56.65 spid39s The resource database build version is 16.00.4195. This is an informational message only. No user action is required.
2025-07-04 19:59:56.69 spid39s [3]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:56.69 spid39s Starting up database 'model'.
2025-07-04 19:59:56.81 spid31s Converting database 'model_replicatedmaster' from version 927 to the current version 957.
2025-07-04 19:59:56.81 spid31s Database 'model_replicatedmaster' running the upgrade step from version 927 to version 928.
2025-07-04 19:59:56.82 spid31s Database 'model_replicatedmaster' running the upgrade step from version 928 to version 929.
2025-07-04 19:59:56.95 spid31s Database 'model_replicatedmaster' running the upgrade step from version 929 to version 930.
2025-07-04 19:59:56.96 spid31s Database 'model_replicatedmaster' running the upgrade step from version 930 to version 931.
2025-07-04 19:59:56.97 spid31s Database 'model_replicatedmaster' running the upgrade step from version 931 to version 932.
2025-07-04 19:59:56.97 spid31s Database 'model_replicatedmaster' running the upgrade step from version 932 to version 933.
2025-07-04 19:59:56.98 spid31s Database 'model_replicatedmaster' running the upgrade step from version 933 to version 934.
2025-07-04 19:59:56.98 spid31s Database 'model_replicatedmaster' running the upgrade step from version 934 to version 935.
2025-07-04 19:59:56.98 spid31s Database 'model_replicatedmaster' running the upgrade step from version 935 to version 936.
2025-07-04 19:59:56.99 spid31s Database 'model_replicatedmaster' running the upgrade step from version 936 to version 937.
2025-07-04 19:59:56.99 spid31s Database 'model_replicatedmaster' running the upgrade step from version 937 to version 938.
2025-07-04 19:59:57.00 spid31s Database 'model_replicatedmaster' running the upgrade step from version 938 to version 939.
2025-07-04 19:59:57.00 spid31s Database 'model_replicatedmaster' running the upgrade step from version 939 to version 940.
2025-07-04 19:59:57.00 spid31s Database 'model_replicatedmaster' running the upgrade step from version 940 to version 941.
2025-07-04 19:59:57.01 spid31s Database 'model_replicatedmaster' running the upgrade step from version 941 to version 942.
2025-07-04 19:59:57.01 spid31s Database 'model_replicatedmaster' running the upgrade step from version 942 to version 943.
2025-07-04 19:59:57.05 spid31s Database 'model_replicatedmaster' running the upgrade step from version 943 to version 944.
2025-07-04 19:59:57.06 spid31s Database 'model_replicatedmaster' running the upgrade step from version 944 to version 945.
2025-07-04 19:59:57.06 Server External governance manager initialized
2025-07-04 19:59:57.09 spid31s Database 'model_replicatedmaster' running the upgrade step from version 945 to version 946.
2025-07-04 19:59:57.09 spid31s Database 'model_replicatedmaster' running the upgrade step from version 946 to version 947.
2025-07-04 19:59:57.10 spid31s Database 'model_replicatedmaster' running the upgrade step from version 947 to version 948.
2025-07-04 19:59:57.10 spid31s Database 'model_replicatedmaster' running the upgrade step from version 948 to version 949.
2025-07-04 19:59:57.11 spid31s Database 'model_replicatedmaster' running the upgrade step from version 949 to version 950.
2025-07-04 19:59:57.11 spid31s Database 'model_replicatedmaster' running the upgrade step from version 950 to version 951.
2025-07-04 19:59:57.13 spid31s Database 'model_replicatedmaster' running the upgrade step from version 951 to version 952.
2025-07-04 19:59:57.13 spid31s Database 'model_replicatedmaster' running the upgrade step from version 952 to version 953.
2025-07-04 19:59:57.14 spid31s Database 'model_replicatedmaster' running the upgrade step from version 953 to version 954.
2025-07-04 19:59:57.15 spid31s Database 'model_replicatedmaster' running the upgrade step from version 954 to version 955.
2025-07-04 19:59:57.15 spid31s Database 'model_replicatedmaster' running the upgrade step from version 955 to version 956.
2025-07-04 19:59:57.16 Server Common language runtime (CLR) functionality initialized.
2025-07-04 19:59:57.18 spid31s Database 'model_replicatedmaster' running the upgrade step from version 956 to version 957.
2025-07-04 19:59:57.21 spid31s [32761]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:57.21 spid31s Starting up database 'model_msdb'.
2025-07-04 19:59:57.22 spid42s A self-generated certificate was successfully loaded for encryption.
2025-07-04 19:59:57.23 spid42s Server is listening on [ 'any' <ipv6> 1433] accept sockets 1.
2025-07-04 19:59:57.23 spid42s Server is listening on [ 'any' <ipv4> 1433] accept sockets 1.
2025-07-04 19:59:57.23 Server Server is listening on [ ::1 <ipv6> 1434] accept sockets 1.
2025-07-04 19:59:57.24 Server Server is listening on [ 127.0.0.1 <ipv4> 1434] accept sockets 1.
2025-07-04 19:59:57.24 Server Dedicated admin connection support was established for listening locally on port 1434.
2025-07-04 19:59:57.24 spid42s Server is listening on [ ::1 <ipv6> 1431] accept sockets 1.
2025-07-04 19:59:57.24 spid42s Server is listening on [ 127.0.0.1 <ipv4> 1431] accept sockets 1.
2025-07-04 19:59:57.25 spid42s SQL Server is now ready for client connections. This is an informational message; no user action is required.
2025-07-04 19:59:57.30 spid31s Converting database 'model_msdb' from version 927 to the current version 957.
2025-07-04 19:59:57.30 spid31s Database 'model_msdb' running the upgrade step from version 927 to version 928.
2025-07-04 19:59:57.30 spid31s Database 'model_msdb' running the upgrade step from version 928 to version 929.
2025-07-04 19:59:57.32 spid31s Database 'model_msdb' running the upgrade step from version 929 to version 930.
2025-07-04 19:59:57.33 spid31s Database 'model_msdb' running the upgrade step from version 930 to version 931.
2025-07-04 19:59:57.33 spid31s Database 'model_msdb' running the upgrade step from version 931 to version 932.
2025-07-04 19:59:57.34 spid31s Database 'model_msdb' running the upgrade step from version 932 to version 933.
2025-07-04 19:59:57.34 spid31s Database 'model_msdb' running the upgrade step from version 933 to version 934.
2025-07-04 19:59:57.34 spid31s Database 'model_msdb' running the upgrade step from version 934 to version 935.
2025-07-04 19:59:57.35 spid31s Database 'model_msdb' running the upgrade step from version 935 to version 936.
2025-07-04 19:59:57.35 spid31s Database 'model_msdb' running the upgrade step from version 936 to version 937.
2025-07-04 19:59:57.35 spid31s Database 'model_msdb' running the upgrade step from version 937 to version 938.
2025-07-04 19:59:57.36 spid31s Database 'model_msdb' running the upgrade step from version 938 to version 939.
2025-07-04 19:59:57.36 spid31s Database 'model_msdb' running the upgrade step from version 939 to version 940.
2025-07-04 19:59:57.36 spid31s Database 'model_msdb' running the upgrade step from version 940 to version 941.
2025-07-04 19:59:57.36 spid31s Database 'model_msdb' running the upgrade step from version 941 to version 942.
2025-07-04 19:59:57.37 spid31s Database 'model_msdb' running the upgrade step from version 942 to version 943.
2025-07-04 19:59:57.39 spid31s Database 'model_msdb' running the upgrade step from version 943 to version 944.
2025-07-04 19:59:57.39 spid31s Database 'model_msdb' running the upgrade step from version 944 to version 945.
2025-07-04 19:59:57.41 spid31s Database 'model_msdb' running the upgrade step from version 945 to version 946.
2025-07-04 19:59:57.41 spid31s Database 'model_msdb' running the upgrade step from version 946 to version 947.
2025-07-04 19:59:57.41 spid31s Database 'model_msdb' running the upgrade step from version 947 to version 948.
2025-07-04 19:59:57.42 spid31s Database 'model_msdb' running the upgrade step from version 948 to version 949.
2025-07-04 19:59:57.42 spid31s Database 'model_msdb' running the upgrade step from version 949 to version 950.
2025-07-04 19:59:57.43 spid31s Database 'model_msdb' running the upgrade step from version 950 to version 951.
2025-07-04 19:59:57.44 spid31s Database 'model_msdb' running the upgrade step from version 951 to version 952.
2025-07-04 19:59:57.44 spid31s Database 'model_msdb' running the upgrade step from version 952 to version 953.
2025-07-04 19:59:57.45 spid31s Database 'model_msdb' running the upgrade step from version 953 to version 954.
2025-07-04 19:59:57.45 spid31s Database 'model_msdb' running the upgrade step from version 954 to version 955.
2025-07-04 19:59:57.45 spid31s Database 'model_msdb' running the upgrade step from version 955 to version 956.
2025-07-04 19:59:57.47 spid31s Database 'model_msdb' running the upgrade step from version 956 to version 957.
2025-07-04 19:59:57.51 spid44s Attribute synchronization initialized
2025-07-04 19:59:57.51 spid31s Resource governor reconfiguration succeeded.
2025-07-04 19:59:57.51 spid44s Attribute synchronization manager initialized
2025-07-04 19:59:57.51 spid31s SQL Server Audit is starting the audits. This is an informational message. No user action is required.
2025-07-04 19:59:57.51 spid31s SQL Server Audit has started the audits. This is an informational message. No user action is required.
2025-07-04 19:59:57.57 spid31s SQL Trace ID 1 was started by login "sa".
2025-07-04 19:59:57.58 spid31s Server name is '12d2f26c5ab5'. This is an informational message only. No user action is required.
2025-07-04 19:59:57.60 spid39s Clearing tempdb database.
2025-07-04 19:59:57.60 spid52s Always On: The availability replica manager is starting. This is an informational message only. No user action is required.
2025-07-04 19:59:57.61 spid52s Always On: The availability replica manager is waiting for the instance of SQL Server to allow client connections. This is an informational message only. No user action is required.
2025-07-04 19:59:57.61 spid55s [4]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:57.61 spid54s [5]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:57.62 spid55s Starting up database 'msdb'.
2025-07-04 19:59:57.62 spid54s Starting up database 'prole'.
2025-07-04 19:59:57.62 spid54s RemoveStaleDbEntries: Cleanup of stale DB entries called for database ID: [5]
2025-07-04 19:59:57.62 spid54s RemoveStaleDbEntries: Cleanup of stale DB entries skipped because master db is not memory optimized. DbId: 5.
2025-07-04 19:59:57.70 spid54s Parallel redo is started for database 'prole' with worker pool size [5].
2025-07-04 19:59:57.74 spid55s 1 transactions rolled forward in database 'msdb' (4:0). This is an informational message only. No user action is required.
2025-07-04 19:59:57.81 spid31s 0 transactions rolled back in database 'msdb' (4:0). This is an informational message only. No user action is required.
2025-07-04 19:59:57.82 spid39s [2]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 1. ConcurrentSGAMUpdate: 1, CleanupUnderUserTransaction: 0. TranLevelPVS: 0
2025-07-04 19:59:57.83 spid39s Starting up database 'tempdb'.
2025-07-04 19:59:57.83 spid54s Recovery of database 'prole' (5) is 0% complete (approximately 31 seconds remain). Phase 2 of 3. This is an informational message only. No user action is required.
2025-07-04 19:59:58.04 spid54s 14 transactions rolled forward in database 'prole' (5:0). This is an informational message only. No user action is required.
2025-07-04 19:59:58.08 spid54s 0 transactions rolled back in database 'prole' (5:0). This is an informational message only. No user action is required.
2025-07-04 19:59:58.09 spid54s Parallel redo is shutdown for database 'prole' with worker pool size [5].
2025-07-04 19:59:58.67 spid39s The tempdb database has 8 data file(s).
2025-07-04 19:59:58.68 spid45s The Service Broker endpoint is in disabled or stopped state.
2025-07-04 19:59:58.68 spid45s The Database Mirroring endpoint is in disabled or stopped state.
2025-07-04 19:59:58.69 spid45s Service Broker manager has started.
2025-07-04 19:59:58.69 spid31s Recovery is complete. This is an informational message only. No user action is required.
2025-07-04 20:06:56.36 spid57 Attempting to load library 'xplog70.dll' into memory. This is an informational message only. No user action is required.
2025-07-04 20:06:56.40 spid57 Using 'xplog70.dll' version '2022.160.4195' to execute extended stored procedure 'xp_msver'. This is an informational message only; no user action is required.
2025-07-04 20:08:50.88 spid57 Using 'dbghelp.dll' version '4.0.5'
2025-07-04 20:59:54.45 spid48s [DevOpsSnapshotTelemetryTask] Evaluating the background task.