Azure SQL Edge will run as non-root by default.
This container is running as user mssql.
To learn more visit https://go.microsoft.com/fwlink/?linkid=2140520.
2022-03-10 07:49:43.85 Server      The licensing PID was successfully processed. The new edition is [Azure SQL Edge Developer].
2022-03-10 07:49:44.37 Server      Setup step is copying system data file 'C:\templatedata\master.mdf' to '/var/opt/mssql/data/master.mdf'.
2022-03-10 07:49:44.39 Server      Did not find an existing master data file /var/opt/mssql/data/master.mdf, copying the missing default master and other system database files. If you have moved the database location, but not moved the database files, startup may fail. To repair: shutdown SQL Server, move the master database to configured location, and restart.
2022-03-10 07:49:44.39 Server      Setup step is copying system data file 'C:\templatedata\mastlog.ldf' to '/var/opt/mssql/data/mastlog.ldf'.
2022-03-10 07:49:44.40 Server      Setup step is copying system data file 'C:\templatedata\model.mdf' to '/var/opt/mssql/data/model.mdf'.
2022-03-10 07:49:44.41 Server      Setup step is copying system data file 'C:\templatedata\modellog.ldf' to '/var/opt/mssql/data/modellog.ldf'.
2022-03-10 07:49:44.43 Server      Setup step is copying system data file 'C:\templatedata\msdbdata.mdf' to '/var/opt/mssql/data/msdbdata.mdf'.
2022-03-10 07:49:44.46 Server      Setup step is copying system data file 'C:\templatedata\msdblog.ldf' to '/var/opt/mssql/data/msdblog.ldf'.
2022-03-10 07:49:44.46 Server      Setup step is copying system data file 'C:\templatedata\model_replicatedmaster.mdf' to '/var/opt/mssql/data/model_replicatedmaster.mdf'.
2022/03/10 07:49:40 [launchpadd] INFO: Extensibility Log Header: <timestamp> <process> <sandboxId> <sessionId> <message>
2022/03/10 07:49:40 [launchpadd] WARNING: Failed to load /var/opt/mssql/mssql.conf ini file with error open /var/opt/mssql/mssql.conf: no such file or directory
2022/03/10 07:49:40 [launchpadd] INFO: DataDirectories =  /bin:/etc:/lib:/lib32:/lib64:/sbin:/usr/bin:/usr/include:/usr/lib:/usr/lib32:/usr/lib64:/usr/libexec/gcc:/usr/sbin:/usr/share:/var/lib:/opt/microsoft:/opt/mssql-extensibility:/opt/mssql/mlservices:/opt/mssql/lib/zulu-jre-11:/opt/mssql-tools
2022/03/10 07:49:40 Drop permitted effective capabilities.
2022/03/10 07:49:41 [launchpadd] INFO: Polybase remote hadoop bridge disabled
2022/03/10 07:49:41 [launchpadd] INFO: Launchpadd is connecting to mssql on localhost:1431
2022/03/10 07:49:41 [launchpadd] WARNING: Failed to connect to SQL because: dial tcp 127.0.0.1:1431: connect: connection refused, will reattempt connection.
2022/03/10 07:49:42 [launchpadd] WARNING: Failed to connect to SQL because: dial tcp 127.0.0.1:1431: connect: connection refused, will reattempt connection.
2022/03/10 07:49:43 [launchpadd] WARNING: Failed to connect to SQL because: dial tcp 127.0.0.1:1431: connect: connection refused, will reattempt connection.
2022/03/10 07:49:44 [launchpadd] WARNING: Failed to connect to SQL because: dial tcp 127.0.0.1:1431: connect: connection refused, will reattempt connection.
2022/03/10 07:49:45 [launchpadd] WARNING: Failed to connect to SQL because: dial tcp 127.0.0.1:1431: connect: connection refused, will reattempt connection.
2022-03-10 07:49:44.48 Server      Setup step is copying system data file 'C:\templatedata\model_replicatedmaster.ldf' to '/var/opt/mssql/data/model_replicatedmaster.ldf'.
2022-03-10 07:49:44.48 Server      Setup step is copying system data file 'C:\templatedata\model_msdbdata.mdf' to '/var/opt/mssql/data/model_msdbdata.mdf'.
2022-03-10 07:49:44.50 Server      Setup step is copying system data file 'C:\templatedata\model_msdblog.ldf' to '/var/opt/mssql/data/model_msdblog.ldf'.
2022-03-10 07:49:44.60 Server      Microsoft Azure SQL Edge Developer (RTM) - 15.0.2000.1562 (ARM64) 
Jan 14 2022 15:23:35 
Copyright (C) 2019 Microsoft Corporation
Linux (Ubuntu 18.04.6 LTS aarch64) <ARM64>
2022-03-10 07:49:44.60 Server      UTC adjustment: 0:00
2022-03-10 07:49:44.60 Server      (c) Microsoft Corporation.
2022-03-10 07:49:44.60 Server      All rights reserved.
2022-03-10 07:49:44.60 Server      Server process ID is 32.
2022-03-10 07:49:44.61 Server      Logging SQL Server messages in file '/var/opt/mssql/log/errorlog'.
2022-03-10 07:49:44.61 Server      Registry startup parameters: 
 -d /var/opt/mssql/data/master.mdf
 -l /var/opt/mssql/data/mastlog.ldf
 -e /var/opt/mssql/log/errorlog
2022-03-10 07:49:44.61 Server      SQL Server detected 1 sockets with 4 cores per socket and 4 logical processors per socket, 4 total logical processors; using 4 logical processors based on SQL Server licensing. This is an informational message; no user action is required.
2022-03-10 07:49:44.62 Server      SQL Server is starting at normal priority base (=7). This is an informational message only. No user action is required.
2022-03-10 07:49:44.62 Server      Detected 1591 MB of RAM. This is an informational message; no user action is required.
2022-03-10 07:49:44.62 Server      Using conventional memory in the memory manager.
2022-03-10 07:49:44.63 Server      Page exclusion bitmap is enabled.
2022-03-10 07:49:44.65 Server      Buffer Pool: Allocating 131072 bytes for 92802 hashPages.
2022-03-10 07:49:45.08 Server      Buffer pool extension is already disabled. No action is necessary.
2022-03-10 07:49:46.55 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'].
2022-03-10 07:49:46.59 Server      Query Store settings initialized with enabled = 1, 
2022-03-10 07:49:46.63 Server      Node configuration: node 0: CPU mask: 0x000000000000000f:0 Active CPU mask: 0x000000000000000f:0. This message provides a description of the NUMA configuration for this computer. This is an informational message only. No user action is required.
2022-03-10 07:49:46.64 Server      Using dynamic lock allocation.  Initial allocation of 500 Lock blocks and 1000 Lock Owner blocks per node.  This is an informational message only.  No user action is required.
2022-03-10 07:49:46.66 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.
ForceFlush is enabled for this instance. 
2022-03-10 07:49:46.67 Server      Total Log Writer threads: 1. This is an informational message; no user action is required.
2022-03-10 07:49:46.67 Server      Software Usage Metrics is disabled.
2022-03-10 07:49:46.70 spid8s      [1]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 0. CleanupUnderUserTransaction: 0.
2022-03-10 07:49:46.71 spid8s      Starting up database 'master'.
2022-03-10 07:49:46.77 spid8s      Refresh DEK for DBID: [1] File Id: [1] - Zeroring encryption state
2022-03-10 07:49:46.77 spid8s      The DEK is already set for DBID = [1] file id 1.
2022-03-10 07:49:46.83 spid8s      Refresh DEK for DBID: [1] File Id: [2] - Zeroring encryption state
2022-03-10 07:49:46.83 spid8s      The DEK is already set for DBID = [1] file id 2.
ForceFlush feature is enabled for log durability.
2022-03-10 07:49:46.84 spid8s      The tail of the log for database master is being rewritten to match the new sector size of 4096 bytes.  2560 bytes at offset 390656 in file /var/opt/mssql/data/mastlog.ldf will be written.
2022-03-10 07:49:46.95 spid8s      Converting database 'master' from version 915 to the current version 921.
2022-03-10 07:49:46.95 spid8s      Database 'master' running the upgrade step from version 915 to version 916.
2022-03-10 07:49:46.96 spid8s      Database 'master' running the upgrade step from version 916 to version 917.
2022-03-10 07:49:46.98 spid8s      Database 'master' running the upgrade step from version 917 to version 918.
2022-03-10 07:49:46.99 spid8s      Database 'master' running the upgrade step from version 918 to version 919.
2022-03-10 07:49:46.99 spid8s      Database 'master' running the upgrade step from version 919 to version 920.
2022-03-10 07:49:47.02 spid8s      Database 'master' running the upgrade step from version 920 to version 921.
2022-03-10 07:49:47.29 spid8s      SQL Server Audit is starting the audits. This is an informational message. No user action is required.
2022-03-10 07:49:47.29 spid8s      SQL Server Audit has started the audits. This is an informational message. No user action is required.
2022-03-10 07:49:47.34 spid8s      SQL Trace ID 1 was started by login "sa".
2022-03-10 07:49:47.35 spid8s      Server name is '42a0a26d667f'. This is an informational message only. No user action is required.
2022-03-10 07:49:47.35 spid22s     Password policy update was successful.
2022-03-10 07:49:47.36 spid8s      [4]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 0. CleanupUnderUserTransaction: 0.
2022-03-10 07:49:47.36 spid11s     [32767]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 0. CleanupUnderUserTransaction: 0.
2022-03-10 07:49:47.36 spid8s      Starting up database 'msdb'.
2022-03-10 07:49:47.37 spid11s     Starting up database 'mssqlsystemresource'.
2022-03-10 07:49:47.37 spid11s     Refresh DEK for DBID: [32767] File Id: [1] - Copying encryption state
2022-03-10 07:49:47.38 spid11s     DBID: [32767] File Header for File Id: [1] was read with state = 0.
2022-03-10 07:49:47.38 spid11s     DBID: [32767] No DEK update for File Id: [1] while existing DEK is null.
2022-03-10 07:49:47.38 spid11s     The resource database build version is 15.00.2000. This is an informational message only. No user action is required.
2022-03-10 07:49:47.39 spid11s     Refresh DEK for DBID: [32767] File Id: [2] - Copying encryption state
2022-03-10 07:49:47.40 spid11s     DBID: [32767] File Header for File Id: [2] was read with state = 0.
2022-03-10 07:49:47.40 spid11s     DBID: [32767] No DEK update for File Id: [2] while existing DEK is null.
2022-03-10 07:49:47.43 spid11s     [3]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 0. CleanupUnderUserTransaction: 0.
2022-03-10 07:49:47.44 spid11s     Starting up database 'model'.
2022-03-10 07:49:47.46 spid8s      Refresh DEK for DBID: [4] File Id: [1] - Copying encryption state
2022-03-10 07:49:47.46 spid22s     A self-generated certificate was successfully loaded for encryption.
2022-03-10 07:49:47.47 spid8s      DBID: [4] File Header for File Id: [1] was read with state = 0.
2022-03-10 07:49:47.47 spid8s      DBID: [4] No DEK update for File Id: [1] while existing DEK is null.
2022-03-10 07:49:47.48 spid22s     Server is listening on [ 'any' <ipv6> 1433] accept sockets 1.
2022-03-10 07:49:47.48 spid22s     Server is listening on [ 'any' <ipv4> 1433] accept sockets 1.
2022-03-10 07:49:47.49 spid22s     Dedicated administrator connection support was not started because it is disabled on this edition of SQL Server. If you want to use a dedicated administrator connection, restart SQL Server using the trace flag 7806. This is an informational message only. No user action is required.
2022-03-10 07:49:47.50 spid22s     Server is listening on [ ::1 <ipv6> 1431] accept sockets 1.
2022-03-10 07:49:47.50 spid22s     Server is listening on [ 127.0.0.1 <ipv4> 1431] accept sockets 1.
2022-03-10 07:49:47.50 spid22s     SQL Server is now ready for client connections. This is an informational message; no user action is required.
2022-03-10 07:49:47.52 spid11s     Refresh DEK for DBID: [3] File Id: [1] - Zeroring encryption state
2022-03-10 07:49:47.53 spid11s     The DEK is already set for DBID = [3] file id 1.
2022-03-10 07:49:47.56 spid8s      Refresh DEK for DBID: [4] File Id: [2] - Copying encryption state
2022-03-10 07:49:47.57 spid8s      DBID: [4] File Header for File Id: [2] was read with state = 0.
2022-03-10 07:49:47.57 spid8s      DBID: [4] No DEK update for File Id: [2] while existing DEK is null.
2022-03-10 07:49:47.58 spid8s      The tail of the log for database msdb is being rewritten to match the new sector size of 4096 bytes.  1536 bytes at offset 51712 in file /var/opt/mssql/data/MSDBLog.ldf will be written.
2022-03-10 07:49:47.60 spid11s     Refresh DEK for DBID: [3] File Id: [2] - Zeroring encryption state
2022-03-10 07:49:47.61 spid11s     The DEK is already set for DBID = [3] file id 2.
2022-03-10 07:49:47.61 spid11s     The tail of the log for database model is being rewritten to match the new sector size of 4096 bytes.  512 bytes at offset 73216 in file /var/opt/mssql/data/modellog.ldf will be written.
2022-03-10 07:49:47.61 spid8s      Converting database 'msdb' from version 899 to the current version 921.
2022-03-10 07:49:47.62 spid8s      Database 'msdb' running the upgrade step from version 899 to version 900.
2022-03-10 07:49:47.64 spid11s     Converting database 'model' from version 899 to the current version 921.
2022-03-10 07:49:47.64 spid11s     Database 'model' running the upgrade step from version 899 to version 900.
2022-03-10 07:49:47.65 spid8s      Database 'msdb' running the upgrade step from version 900 to version 901.
2022-03-10 07:49:47.66 spid8s      Database 'msdb' running the upgrade step from version 901 to version 902.
2022-03-10 07:49:47.66 spid11s     Database 'model' running the upgrade step from version 900 to version 901.
2022-03-10 07:49:47.67 spid11s     Database 'model' running the upgrade step from version 901 to version 902.
2022-03-10 07:49:47.68 spid11s     Database 'model' running the upgrade step from version 902 to version 903.
2022-03-10 07:49:47.68 spid11s     Database 'model' running the upgrade step from version 903 to version 904.
2022-03-10 07:49:47.69 spid11s     Database 'model' running the upgrade step from version 904 to version 905.
2022-03-10 07:49:47.70 spid11s     Database 'model' running the upgrade step from version 905 to version 906.
Cleaning up SEReplicated flag from rowsets.
2022-03-10 07:49:47.73 spid11s     Database 'model' running the upgrade step from version 906 to version 907.
2022-03-10 07:49:47.73 spid11s     Database 'model' running the upgrade step from version 907 to version 908.
2022-03-10 07:49:47.74 spid11s     Database 'model' running the upgrade step from version 908 to version 909.
2022-03-10 07:49:47.74 spid11s     Database 'model' running the upgrade step from version 909 to version 910.
2022-03-10 07:49:47.75 spid11s     Database 'model' running the upgrade step from version 910 to version 911.
2022-03-10 07:49:47.76 spid11s     Database 'model' running the upgrade step from version 911 to version 912.
2022-03-10 07:49:47.77 spid11s     Database 'model' running the upgrade step from version 912 to version 913.
2022-03-10 07:49:47.78 spid11s     Database 'model' running the upgrade step from version 913 to version 914.
2022-03-10 07:49:47.79 spid11s     Database 'model' running the upgrade step from version 914 to version 915.
2022-03-10 07:49:47.80 spid11s     Database 'model' running the upgrade step from version 915 to version 916.
2022-03-10 07:49:47.80 spid11s     Database 'model' running the upgrade step from version 916 to version 917.
2022-03-10 07:49:47.81 spid11s     Database 'model' running the upgrade step from version 917 to version 918.
2022-03-10 07:49:47.82 spid11s     Database 'model' running the upgrade step from version 918 to version 919.
2022-03-10 07:49:47.83 spid11s     Database 'model' running the upgrade step from version 919 to version 920.
2022-03-10 07:49:47.84 spid11s     Database 'model' running the upgrade step from version 920 to version 921.
2022-03-10 07:49:47.90 spid11s     Clearing tempdb database.
2022-03-10 07:49:48.10 spid11s     Refresh DEK for DBID: [2] File Id: [1] - Copying encryption state
2022-03-10 07:49:48.11 spid11s     DBID: [2] File Header for File Id: [1] was read with state = 0.
2022-03-10 07:49:48.11 spid11s     DBID: [2] No DEK update for File Id: [1] while existing DEK is null.
2022-03-10 07:49:48.11 Server      Configuring Always Encrypted enclave in asynchronous mode.
2022-03-10 07:49:48.14 spid11s     Refresh DEK for DBID: [2] File Id: [2] - Copying encryption state
2022-03-10 07:49:48.14 spid11s     DBID: [2] File Header for File Id: [2] was read with state = 0.
2022-03-10 07:49:48.14 spid11s     DBID: [2] No DEK update for File Id: [2] while existing DEK is null.
2022-03-10 07:49:48.15 spid11s     [2]. Feature Status: PVS: 0. CTR: 0. ConcurrentPFSUpdate: 1. ConcurrentGAMUpdate: 0. CleanupUnderUserTransaction: 0.
2022-03-10 07:49:48.15 spid11s     Starting up database 'tempdb'.
2022-03-10 07:49:48.20 spid11s     Refresh DEK for DBID: [2] File Id: [1] - Copying encryption state
2022-03-10 07:49:48.20 spid11s     DBID: [2] File Header for File Id: [1] was read with state = 0.
2022-03-10 07:49:48.21 spid11s     DBID: [2] No DEK update for File Id: [1] while existing DEK is null.
2022-03-10 07:49:48.24 Server      Server is listening on [ 127.0.0.1 <ipv4> 14300] accept sockets 1.
2022-03-10 07:49:48.25 Server      Server is listening on [ 127.0.0.1 <ipv4> 38875] accept sockets 1.
2022-03-10 07:49:48.26 spid11s     Refresh DEK for DBID: [2] File Id: [2] - Copying encryption state
2022-03-10 07:49:48.27 spid11s     DBID: [2] File Header for File Id: [2] was read with state = 0.
2022-03-10 07:49:48.27 spid11s     DBID: [2] No DEK update for File Id: [2] while existing DEK is null.
2022-03-10 07:49:48.34 spid11s     The tempdb database has 1 data file(s).
2022-03-10 07:49:48.35 spid26s     The Service Broker endpoint is in disabled or stopped state.
2022-03-10 07:49:48.36 spid26s     The Database Mirroring endpoint is in disabled or stopped state.
2022-03-10 07:49:48.39 spid26s     Service Broker manager has started.
2022-03-10 07:49:48.39 spid8s      Database 'msdb' running the upgrade step from version 902 to version 903.
2022-03-10 07:49:48.42 spid8s      Database 'msdb' running the upgrade step from version 903 to version 904.
2022-03-10 07:49:48.44 spid8s      Database 'msdb' running the upgrade step from version 904 to version 905.
2022-03-10 07:49:48.46 spid8s      Database 'msdb' running the upgrade step from version 905 to version 906.
Cleaning up SEReplicated flag from rowsets.
2022-03-10 07:49:48.50 spid8s      Database 'msdb' running the upgrade step from version 906 to version 907.
2022-03-10T07:49:48.511Z [dotnet /app/ASDE.Dotnet.dll] [165] ASDE.Dotnet starting up
2022-03-10 07:49:48.51 spid8s      Database 'msdb' running the upgrade step from version 907 to version 908.
2022-03-10T07:49:48.516Z [dotnet /app/ASDE.Dotnet.dll] [165] MSSQL_LCID: 
2022-03-10 07:49:48.52 spid8s      Database 'msdb' running the upgrade step from version 908 to version 909.
2022-03-10 07:49:48.52 spid8s      Database 'msdb' running the upgrade step from version 909 to version 910.
2022-03-10 07:49:48.53 spid8s      Database 'msdb' running the upgrade step from version 910 to version 911.
2022-03-10 07:49:48.54 spid8s      Database 'msdb' running the upgrade step from version 911 to version 912.
2022-03-10 07:49:48.55 spid8s      Database 'msdb' 2022-03-10T07:49:48.561Z [dotnet /app/ASDE.Dotnet.dll] [165] rCreating ASA Job Manager with: OfflineEdgeHubClientWrapper
unning the upgrade step from version 912 to version 913.
2022/03/10 07:49:48 [launchpadd] INFO: Connection opened from 127.0.0.1:40284 to 127.0.0.1:1431
2022/03/10 07:49:48 [launchpadd] INFO: Sending message of type 20 [MessageTypePackageLauncherConnect], SessionID:00000000-0000-0000-0000-000000000000
2022/03/10 07:49:48 [launchpadd] INFO: Sent message of type 20 [MessageTypePackageLauncherConnect], SessionID:00000000-0000-0000-0000-000000000000
2022/03/10 07:49:48 [launchpadd] INFO: Received packet of type 17 [MessageTypeXdbDataPackageStart]
2022/03/10 07:49:48 [launchpadd] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32785 PacketSizeInBytes:310 SessionID:2b8344de-8d97-49dd-9fec-43312ff0cf7b}
2022/03/10 07:49:48 [launchpadd] INFO: DataPackageStart message is received with package GUID=bd00e8cc-bc66-4ef0-90fb-2ca3e23d27c9, SandboxFileMappingEntryCount=0, Configuration=6.
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Sending message of type 19 [MessageTypeXdbPackageResume], SessionID:2b8344de-8d97-49dd-9fec-43312ff0cf7b
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Sent message of type 19 [MessageTypeXdbPackageResume], SessionID:2b8344de-8d97-49dd-9fec-43312ff0cf7b
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Received packet of type 12 [MessageTypeAck]
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32780 PacketSizeInBytes:28 SessionID:bd00e8cc-bc66-4ef0-90fb-2ca3e23d27c9}
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Starting launchpad for bd00e8cc-bc66-4ef0-90fb-2ca3e23d27c9
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Create sandbox directory /var/opt/mssql-extensibility/data/bd00e8cc-bc66-4ef0-90fb-2ca3e23d27c9  with uid= 10001 gid= 0 perms= -rwxrwxr-x
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Change owner and permissions for sandbox directory /var/opt/mssql-extensibility/data/bd00e8cc-bc66-4ef0-90fb-2ca3e23d27c9 uid= 10001 gid= 0 perms= -rwxrwxr-x
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: mountExtMgmtPaths
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: env var EXT_MGR_PATH_COUNT not set: strconv.Atoi: parsing "": invalid syntax 
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Mount external language or library paths, EXT_MGR_PATH_COUNT=0 
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: In no isolation mode, running /opt/mssql-extensibility/bin/launchpad with args [-hostname 127.0.0.1 -sandboxWorkingDir /var/opt/mssql-extensibility/data/bd00e8cc-bc66-4ef0-90fb-2ca3e23d27c9 -reparentOrphanedDescendants=true -useDefaultLaunchers=false]
2022/03/10 07:49:48 [launchpadd] [bd00e8cc] INFO: Started launchpad with pid:152
2022/03/10 07:49:48 [launchpad] [bd00e8cc] INFO: Launchpad is connecting to mssql on 127.0.0.1:14300
2022/03/10 07:49:48 [launchpad] [bd00e8cc] INFO: Setting PR_SET_CHILD_SUBREAPER
2022/03/10 07:49:48 [launchpad] [bd00e8cc] INFO: Received packet of type 8 [MessageTypeServiceStart]
2022/03/10 07:49:48 [launchpad] [bd00e8cc] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32776 PacketSizeInBytes:426 SessionID:00000001-0000-0000-0000-000000000000}
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Start processPacketLoop for SessionID: 00000001-0000-0000-0000-000000000000
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Launching satellite for SessionID: 00000001-0000-0000-0000-000000000000
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Cleaning up prior external service lifetime for groups map[]
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Cleanup of prior external service lifetime complete
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Starting script dotnet /app/ASDE.Dotnet.dll 00000001-0000-0000-0000-000000000000
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Sending message of type 3 [MessageTypeResumeWithLogin], SessionID:00000001-0000-0000-0000-000000000000
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Sent message of type 3 [MessageTypeResumeWithLogin], SessionID:00000001-0000-0000-0000-000000000000
2022/03/10 07:49:48 [launchpad] [bd00e8cc] [00000001] INFO: Done processing the packet of type 8 [MessageTypeServiceStart]
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [00000001] INFO: Received packet of type 8 [MessageTypeServiceStart]
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [00000001] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32776 PacketSizeInBytes:452 SessionID:0b69cc1c-cf9c-4725-b52a-fccf1f3a038e}
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Start processPacketLoop for SessionID: 0b69cc1c-cf9c-4725-b52a-fccf1f3a038e
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Launching satellite for SessionID: 0b69cc1c-cf9c-4725-b52a-fccf1f3a038e
2022-03-10 07:49:48.57 spid8s      Database 'msdb' running the upgrade step from version 913 to version 914.
2022-03-10 07:49:48.59 spid8s      Database 'msdb' running the upgrade step from version 914 to version 915.
2022-03-10 07:49:48.59 spid8s      Database 'msdb' running the upgrade step from version 915 to version 916.
2022-03-10 07:49:48.60 spid8s      Database 'msdb' running the upgrade step from version 916 to version 917.
2022-03-10 07:49:48.62 spid8s      Database 'msdb' running the upgrade step from version 917 to version 918.
2022-03-12022-03-10T07:49:48.645Z [dotnet /app/ASDE.Dotnet.dll] [165] Initializing ASA Job Manager
0 07:49:48.63 spid8s      Database 'msdb' running the upgrade step from version 918 to version 919.
2022-03-10 07:49:48.64 spid8s      Database 'msdb' running the upgrade step from version 919 to version 920.
2022-03-10T07:49:48.663Z [dotnet /app/ASDE.Dotnet.dll] [165] ASDE.Dotnet entering main loop.
2022-03-10T07:49:48.663Z [dotnet /app/ASDE.Dotnet.dll] [165] Satellite listener exists. Starting ASASatelliteService.
2022-03-10T07:49:48.669Z [dotnet /app/ASDE.Dotnet.dll] [165] Waiting for next message
2022-03-10 07:49:48.66 spid8s      Database 'msdb' running the upgrade step from version 920 to version 921.
2022-03-10 07:49:48.77 spid8s      Recovery is complete. This is an informational message only. No user action is required.
2022-03-10 07:49:48.86 spid25s     The default language (LCID 0) has been set for engine and full-text services.
2022-03-10T07:49:49.167Z [dotnet /app/ASDE.Dotnet.dll] [165] Waiting for next message
2022-03-10T07:49:49.250Z [dotnet /app/ASDE.Dotnet.dll] [165] Operation: NotifyJobsRecovered
2022-03-10T07:49:49.252Z [dotnet /app/ASDE.Dotnet.dll] [165] Job recovery notification received.
2022-03-10T07:49:49.253Z [dotnet /app/ASDE.Dotnet.dll] [165] Operation: NotifyJobsRecovered success: True. message: 
2022-03-10T07:49:49.268Z [dotnet /app/ASDE.Dotnet.dll] [165] Sending response message for b908d406-8136-4a4e-be53-5206729d1d2e with length: 162
2022-03-10T07:49:49.513Z [dotnet /app/sqlceip/EdgeTelemetry.dll] [198] EdgeTelemetry starting up
2022-03-10 07:50:21.88 spid51      Attempting to load library 'xplog70.dll' into memory. This is an informational message only. No user action is required.
2022-03-10 07:50:21.94 spid51      Using 'xplog70.dll' version '2019.150.2000' to execute extended stored procedure 'xp_msver'. This is an informational message only; no user action is required.
The login info is removed from the store and destroyed.
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Cleaning up prior external service lifetime for groups map[]
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Cleanup of prior external service lifetime complete
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Starting script /opt/mssql-extensibility/bin/predicthost 0b69cc1c-cf9c-4725-b52a-fccf1f3a038e
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Sending message of type 3 [MessageTypeResumeWithLogin], SessionID:0b69cc1c-cf9c-4725-b52a-fccf1f3a038e
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Sent message of type 3 [MessageTypeResumeWithLogin], SessionID:0b69cc1c-cf9c-4725-b52a-fccf1f3a038e
2022/03/10 07:49:49 [launchpad] [bd00e8cc] [0b69cc1c] INFO: Done processing the packet of type 8 [MessageTypeServiceStart]
2022/03/10 07:49:49 [launchpadd] [bd00e8cc] INFO: Received packet of type 17 [MessageTypeXdbDataPackageStart]
2022/03/10 07:49:49 [launchpadd] [bd00e8cc] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32785 PacketSizeInBytes:310 SessionID:05671c6f-4c01-4e20-aa45-2bc1f3957c3f}
2022/03/10 07:49:49 [launchpadd] [bd00e8cc] INFO: DataPackageStart message is received with package GUID=5fb9296a-b20f-48f0-9b30-de71bd99b279, SandboxFileMappingEntryCount=0, Configuration=6.
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Sending message of type 19 [MessageTypeXdbPackageResume], SessionID:05671c6f-4c01-4e20-aa45-2bc1f3957c3f
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Sent message of type 19 [MessageTypeXdbPackageResume], SessionID:05671c6f-4c01-4e20-aa45-2bc1f3957c3f
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Received packet of type 12 [MessageTypeAck]
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32780 PacketSizeInBytes:28 SessionID:5fb9296a-b20f-48f0-9b30-de71bd99b279}
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Starting launchpad for 5fb9296a-b20f-48f0-9b30-de71bd99b279
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Create sandbox directory /var/opt/mssql-extensibility/data/5fb9296a-b20f-48f0-9b30-de71bd99b279  with uid= 10001 gid= 0 perms= -rwxrwxr-x
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Change owner and permissions for sandbox directory /var/opt/mssql-extensibility/data/5fb9296a-b20f-48f0-9b30-de71bd99b279 uid= 10001 gid= 0 perms= -rwxrwxr-x
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: mountExtMgmtPaths
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: env var EXT_MGR_PATH_COUNT not set: strconv.Atoi: parsing "": invalid syntax 
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Mount external language or library paths, EXT_MGR_PATH_COUNT=0 
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: In no isolation mode, running /opt/mssql-extensibility/bin/launchpad with args [-hostname 127.0.0.1 -sandboxWorkingDir /var/opt/mssql-extensibility/data/5fb9296a-b20f-48f0-9b30-de71bd99b279 -reparentOrphanedDescendants=true -useDefaultLaunchers=false]
2022/03/10 07:49:49 [launchpadd] [5fb9296a] INFO: Started launchpad with pid:190
2022/03/10 07:49:49 [launchpad] [5fb9296a] INFO: Launchpad is connecting to mssql on 127.0.0.1:14300
2022/03/10 07:49:49 [launchpad] [5fb9296a] INFO: Setting PR_SET_CHILD_SUBREAPER
2022/03/10 07:49:49 [launchpad] [5fb9296a] INFO: Received packet of type 8 [MessageTypeServiceStart]
2022/03/10 07:49:49 [launchpad] [5fb9296a] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32776 PacketSizeInBytes:446 SessionID:00000001-0000-002a-0000-080000000100}
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Start processPacketLoop for SessionID: 00000001-0000-002a-0000-080000000100
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Launching satellite for SessionID: 00000001-0000-002a-0000-080000000100
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Cleaning up prior external service lifetime for groups map[]
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Cleanup of prior external service lifetime complete
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Starting script dotnet /app/sqlceip/EdgeTelemetry.dll 00000001-0000-002a-0000-080000000100
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Sending message of type 3 [MessageTypeResumeWithLogin], SessionID:00000001-0000-002a-0000-080000000100
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Sent message of type 3 [MessageTypeResumeWithLogin], SessionID:00000001-0000-002a-0000-080000000100
2022/03/10 07:49:49 [launchpad] [5fb9296a] [00000001] INFO: Done processing the packet of type 8 [MessageTypeServiceStart]
2022/03/10 07:50:34 [launchpad] [5fb9296a] [00000001] INFO: Logging stopped for 00000001-0000-002a-0000-080000000100
2022/03/10 07:50:34 [launchpad] [5fb9296a] [00000001] INFO: Pid 198 exited with status 0 for SessionID:00000001-0000-002a-0000-080000000100
2022/03/10 07:50:34 [launchpad] [5fb9296a] [00000001] INFO: All current child processes have exited. SessionID:00000001-0000-002a-0000-080000000100
2022/03/10 07:50:34 [launchpad] [5fb9296a] [00000001] WARNING: Error waiting for external service process waitid: no child processes
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: Received packet of type 18 [MessageTypeXdbDataPackageStop]
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: Packet header: &{Version:1 TypeAndEndOfMessageBit:32786 PacketSizeInBytes:40 SessionID:87ae18b1-2d6d-41c5-a75d-4c782a9ef55c}
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: DataPackageStop message is received with package GUID 5fb9296a-b20f-48f0-9b30-de71bd99b279.
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: Launchpad of package GUID 5fb9296a-b20f-48f0-9b30-de71bd99b279 found in the store.
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: Launchpad of package GUID 5fb9296a-b20f-48f0-9b30-de71bd99b279 is terminated.
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: resume after receiving stop message. 
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: Sending message of type 19 [MessageTypeXdbPackageResume], SessionID:87ae18b1-2d6d-41c5-a75d-4c782a9ef55c
2022/03/10 07:50:34 [launchpadd] [5fb9296a] INFO: Sent message of type 19 [MessageTypeXdbPackageResume], SessionID:87ae18b1-2d6d-41c5-a75d-4c782a9ef55c