Open Codixer opened 11 months ago
This is the value/return of RUST_LOG=debug /usr/bin/warpgate --config /etc/warpgate.yaml run
for the compressed connection
19:02:41 INFO Warpgate version=0.8.0
19:02:41 INFO Using config: "/etc/warpgate.yaml"
19:02:41 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=90.201µs
19:02:41 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=13.96µs
19:02:41 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=13.08µs
19:02:41 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=12.44µs
19:02:41 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=13.24µs
19:02:41 INFO summary="CREATE TABLE IF NOT …" db.statement="\n\nCREATE TABLE IF NOT EXISTS \"seaql_migrations\" (\n \"version\" text NOT NULL PRIMARY KEY,\n \"applied_at\" bigint NOT NULL\n)\n" rows_affected=0 rows_returned=0 elapsed=236.561µs
19:02:41 INFO Applying all pending migrations
19:02:41 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=14.52µs
19:02:41 INFO summary="CREATE TABLE IF NOT …" db.statement="\n\nCREATE TABLE IF NOT EXISTS \"seaql_migrations\" (\n \"version\" text NOT NULL PRIMARY KEY,\n \"applied_at\" bigint NOT NULL\n)\n" rows_affected=0 rows_returned=0 elapsed=190.401µs
19:02:41 INFO summary="CREATE TABLE IF NOT …" db.statement="\n\nCREATE TABLE IF NOT EXISTS \"seaql_migrations\" (\n \"version\" text NOT NULL PRIMARY KEY,\n \"applied_at\" bigint NOT NULL\n)\n" rows_affected=0 rows_returned=0 elapsed=186.72µs
19:02:41 INFO summary="CREATE TABLE IF NOT …" db.statement="\n\nCREATE TABLE IF NOT EXISTS \"seaql_migrations\" (\n \"version\" text NOT NULL PRIMARY KEY,\n \"applied_at\" bigint NOT NULL\n)\n" rows_affected=0 rows_returned=0 elapsed=163.361µs
19:02:41 INFO summary="SELECT \"version\", \"applied_at\" FROM …" db.statement="\n\nSELECT\n \"version\",\n \"applied_at\"\nFROM\n \"seaql_migrations\"\nORDER BY\n \"version\" ASC\n" rows_affected=0 rows_returned=8 elapsed=92.64µs
19:02:41 INFO No pending migrations
19:02:41 INFO summary="UPDATE \"recordings\" SET \"ended\" …" db.statement="\n\nUPDATE\n \"recordings\"\nSET\n \"ended\" = ?\nWHERE\n \"ended\" IS NULL\n" rows_affected=0 rows_returned=0 elapsed=174.441µs
19:02:41 INFO summary="UPDATE \"sessions\" SET \"ended\" …" db.statement="\n\nUPDATE\n \"sessions\"\nSET\n \"ended\" = ?\nWHERE\n \"ended\" IS NULL\n" rows_affected=0 rows_returned=0 elapsed=234.641µs
19:02:41 INFO summary="SELECT \"roles\".\"id\", \"roles\".\"name\" FROM …" db.statement="\n\nSELECT\n \"roles\".\"id\",\n \"roles\".\"name\"\nFROM\n \"roles\"\n" rows_affected=0 rows_returned=2 elapsed=85.84µs
19:02:41 INFO summary="SELECT \"roles\".\"id\", \"roles\".\"name\" FROM …" db.statement="\n\nSELECT\n \"roles\".\"id\",\n \"roles\".\"name\"\nFROM\n \"roles\"\nWHERE\n \"roles\".\"name\" = ?\n" rows_affected=0 rows_returned=1 elapsed=75.84µs
19:02:41 INFO summary="SELECT \"targets\".\"id\", \"targets\".\"name\", \"targets\".\"kind\", …" db.statement="\n\nSELECT\n \"targets\".\"id\",\n \"targets\".\"name\",\n \"targets\".\"kind\",\n \"targets\".\"options\"\nFROM\n \"targets\"\nWHERE\n \"targets\".\"kind\" = ?\n" rows_affected=0 rows_returned=1 elapsed=72.56µs
19:02:41 INFO summary="SELECT \"target_roles\".\"id\", \"target_roles\".\"target_id\", \"target_roles\".\"role_id\" …" db.statement="\n\nSELECT\n \"target_roles\".\"id\",\n \"target_roles\".\"target_id\",\n \"target_roles\".\"role_id\"\nFROM\n \"target_roles\"\nWHERE\n \"target_roles\".\"target_id\" = ?\n AND \"target_roles\".\"role_id\" = ?\n" rows_affected=0 rows_returned=1 elapsed=62.52µs
19:02:41 INFO --------------------------------------------
19:02:41 INFO Warpgate is now running.
19:02:41 INFO Accepting SSH connections on 0.0.0.0:2222
19:02:41 INFO Accepting HTTP connections on https://0.0.0.0:8888
19:02:41 INFO Accepting MySQL connections on 0.0.0.0:33306
19:02:41 INFO --------------------------------------------
19:02:41 INFO summary="DELETE FROM \"log\" WHERE …" db.statement="\n\nDELETE FROM\n \"log\"\nWHERE\n \"timestamp\" < ?\n" rows_affected=0 rows_returned=0 elapsed=74.72µs
19:02:41 INFO Listening address=0.0.0.0:2222
19:02:41 INFO summary="SELECT \"recordings\".\"id\", \"recordings\".\"name\", \"recordings\".\"started\", …" db.statement="\n\nSELECT\n \"recordings\".\"id\",\n \"recordings\".\"name\",\n \"recordings\".\"started\",\n \"recordings\".\"ended\",\n \"recordings\".\"session_id\",\n \"recordings\".\"kind\"\nFROM\n \"recordings\"\nWHERE\n \"ended\" IS NOT NULL\n AND \"ended\" < ?\n" rows_affected=0 rows_returned=0 elapsed=105.76µs
19:02:41 INFO summary="DELETE FROM \"sessions\" WHERE …" db.statement="\n\nDELETE FROM\n \"sessions\"\nWHERE\n \"ended\" IS NOT NULL\n AND \"ended\" < ?\n" rows_affected=0 rows_returned=0 elapsed=306.161µs
19:02:41 DEBUG Database cleaned up, next in 60480s
19:02:41 INFO Listening address=0.0.0.0:8888
19:02:41 INFO listening addr=socket://0.0.0.0:8888
19:02:41 INFO server started
19:02:41 INFO tls config loaded.
19:02:41 INFO Listening address=0.0.0.0:33306
19:02:58 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=68.72µs
19:02:58 INFO summary="INSERT INTO \"sessions\" (\"id\", …" db.statement="\n\nINSERT INTO\n \"sessions\" (\"id\", \"remote_address\", \"started\", \"protocol\")\nVALUES\n (?, ?, ?, ?)\n" rows_affected=1 rows_returned=0 elapsed=6.025257ms
19:02:58 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=16.04µs
19:02:58 INFO summary="SELECT \"sessions\".\"id\", \"sessions\".\"target_snapshot\", \"sessions\".\"username\", …" db.statement="\n\nSELECT\n \"sessions\".\"id\",\n \"sessions\".\"target_snapshot\",\n \"sessions\".\"username\",\n \"sessions\".\"remote_address\",\n \"sessions\".\"started\",\n \"sessions\".\"ended\",\n \"sessions\".\"ticket_id\",\n \"sessions\".\"protocol\"\nFROM\n \"sessions\"\nWHERE\n \"sessions\".\"id\" = ?\nLIMIT\n ?\n" rows_affected=0 rows_returned=1 elapsed=260.121µs
19:02:58 DEBUG read_ssh_id: reading
19:02:58 DEBUG read 256
19:02:58 DEBUG Err(Utf8Error { valid_up_to: 31, error_len: Some(1) })
19:02:58 DEBUG server kex init: [20, 179, 103, 134, 154, 119, 122, 13, 186, 75, 122, 25, 51, 193, 69, 109, 218, 0, 0, 0, 76, 99, 117, 114, 118, 101, 50, 53, 53, 49, 57, 45, 115, 104, 97, 50, 53, 54, 44, 99, 117, 114, 118, 101, 50, 53, 53, 49, 57, 45, 115, 104, 97, 50, 53, 54, 64, 108, 105, 98, 115, 115, 104, 46, 111, 114, 103, 44, 100, 105, 102, 102, 105, 101, 45, 104, 101, 108, 108, 109, 97, 110, 45, 103, 114, 111, 117, 112, 49, 52, 45, 115, 104, 97, 50, 53, 54, 0, 0, 0, 45, 115, 115, 104, 45, 101, 100, 50, 53, 53, 49, 57, 44, 114, 115, 97, 45, 115, 104, 97, 50, 45, 50, 53, 54, 44, 114, 115, 97, 45, 115, 104, 97, 50, 45, 53, 49, 50, 44, 115, 115, 104, 45, 114, 115, 97, 0, 0, 0, 85, 99, 104, 97, 99, 104, 97, 50, 48, 45, 112, 111, 108, 121, 49, 51, 48, 53, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 97, 101, 115, 50, 53, 54, 45, 103, 99, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 97, 101, 115, 50, 53, 54, 45, 99, 116, 114, 44, 97, 101, 115, 49, 57, 50, 45, 99, 116, 114, 44, 97, 101, 115, 49, 50, 56, 45, 99, 116, 114, 0, 0, 0, 85, 99, 104, 97, 99, 104, 97, 50, 48, 45, 112, 111, 108, 121, 49, 51, 48, 53, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 97, 101, 115, 50, 53, 54, 45, 103, 99, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 97, 101, 115, 50, 53, 54, 45, 99, 116, 114, 44, 97, 101, 115, 49, 57, 50, 45, 99, 116, 114, 44, 97, 101, 115, 49, 50, 56, 45, 99, 116, 114, 0, 0, 0, 123, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 53, 49, 50, 45, 101, 116, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 50, 53, 54, 45, 101, 116, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 53, 49, 50, 44, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 50, 53, 54, 44, 104, 109, 97, 99, 45, 115, 104, 97, 49, 45, 101, 116, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 104, 109, 97, 99, 45, 115, 104, 97, 49, 0, 0, 0, 123, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 53, 49, 50, 45, 101, 116, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 50, 53, 54, 45, 101, 116, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 53, 49, 50, 44, 104, 109, 97, 99, 45, 115, 104, 97, 50, 45, 50, 53, 54, 44, 104, 109, 97, 99, 45, 115, 104, 97, 49, 45, 101, 116, 109, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 44, 104, 109, 97, 99, 45, 115, 104, 97, 49, 0, 0, 0, 26, 110, 111, 110, 101, 44, 122, 108, 105, 98, 44, 122, 108, 105, 98, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 0, 0, 0, 26, 110, 111, 110, 101, 44, 122, 108, 105, 98, 44, 122, 108, 105, 98, 64, 111, 112, 101, 110, 115, 115, 104, 46, 99, 111, 109, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
19:02:58 DEBUG writing, seqn = 0
19:02:58 DEBUG padding length 8
19:02:58 DEBUG packet_length 660
19:02:58 DEBUG id 256 28
19:02:58 DEBUG reading, len = [0, 0, 5, 212]
19:02:58 DEBUG reading, seqn = 0
19:02:58 DEBUG reading, clear len = 1492
19:02:58 DEBUG read_exact 1496
19:02:58 DEBUG id 256 32
19:02:58 DEBUG id 256 256
19:02:58 DEBUG read_exact done
19:02:58 DEBUG reading, padding_length 4
19:02:58 DEBUG kex 189
19:02:58 DEBUG kex 211
19:02:58 DEBUG kex 219
19:02:58 DEBUG client_compression = Zlib
19:02:58 DEBUG reading, len = [0, 0, 0, 44]
19:02:58 DEBUG reading, seqn = 1
19:02:58 DEBUG reading, clear len = 44
19:02:58 DEBUG read_exact 48
19:02:58 DEBUG read_exact done
19:02:58 DEBUG reading, padding_length 6
19:02:58 DEBUG server_dh
19:02:58 DEBUG server kexdhdone.exchange = Exchange { client_id: CryptoVec { p: 0xffff98002400, size: 26, capacity: 32 }, server_id: CryptoVec { p: 0xffff98002430, size: 20, capacity: 32 }, client_kex_init: CryptoVec { p: 0xffff98009d70, size: 1487, capacity: 2048 }, server_kex_init: CryptoVec { p: 0xffff980028e0, size: 651, capacity: 1024 }, client_ephemeral: CryptoVec { p: 0xffff9800a660, size: 32, capacity: 32 }, server_ephemeral: CryptoVec { p: 0xffff9800a770, size: 32, capacity: 32 } }
19:02:58 DEBUG exchange hash: CryptoVec { p: 0xffff9800a930, size: 32, capacity: 32 }
19:02:58 DEBUG signing with key 0
19:02:58 DEBUG hash: CryptoVec { p: 0xffff9800a930, size: 32, capacity: 32 }
19:02:58 DEBUG key: Ed25519 { public: [191, 153, 152, 192, 50, 136, 29, 62, 15, 14, 242, 137, 203, 83, 251, 207, 114, 241, 78, 115, 25, 137, 152, 162, 3, 14, 81, 133, 222, 252, 205, 202], secret: (hidden) }
19:02:58 DEBUG writing, seqn = 1
19:02:58 DEBUG padding length 8
19:02:58 DEBUG packet_length 188
19:02:58 DEBUG writing, seqn = 2
19:02:58 DEBUG padding length 10
19:02:58 DEBUG packet_length 12
19:02:58 DEBUG reading, len = [0, 0, 0, 12]
19:02:58 DEBUG reading, seqn = 2
19:02:58 DEBUG reading, clear len = 12
19:02:58 DEBUG read_exact 16
19:02:58 DEBUG read_exact done
19:02:58 DEBUG reading, padding_length 10
19:02:58 DEBUG writing, seqn = 3
19:02:58 DEBUG padding length 18
19:02:58 DEBUG packet_length 92
19:02:58 DEBUG reading, len = [58, 39, 216, 78]
19:02:58 DEBUG reading, seqn = 3
19:02:58 DEBUG reading, clear len = 60
19:02:58 DEBUG read_exact 64
19:02:58 DEBUG read_exact done
19:02:58 DEBUG reading, padding_length 0
19:07:45 DEBUG Dropped
19:07:45 INFO Closed session
19:07:45 DEBUG Dropped
19:07:45 DEBUG SSH: Abort requested session=59bbbe53-ab0c-46e2-9348-6c1c1b0b967a
19:07:45 INFO SSH: Client session closed session=59bbbe53-ab0c-46e2-9348-6c1c1b0b967a
19:07:45 INFO SSH: Closed connection session=59bbbe53-ab0c-46e2-9348-6c1c1b0b967a
19:07:45 DEBUG SSH: Dropped session=59bbbe53-ab0c-46e2-9348-6c1c1b0b967a
19:07:45 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=202.681µs
19:07:45 INFO summary="SELECT \"sessions\".\"id\", \"sessions\".\"target_snapshot\", \"sessions\".\"username\", …" db.statement="\n\nSELECT\n \"sessions\".\"id\",\n \"sessions\".\"target_snapshot\",\n \"sessions\".\"username\",\n \"sessions\".\"remote_address\",\n \"sessions\".\"started\",\n \"sessions\".\"ended\",\n \"sessions\".\"ticket_id\",\n \"sessions\".\"protocol\"\nFROM\n \"sessions\"\nWHERE\n \"sessions\".\"id\" = ?\nLIMIT\n ?\n" rows_affected=0 rows_returned=1 elapsed=273.601µs
19:07:45 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=13.72µs
19:07:45 INFO summary="UPDATE \"sessions\" SET \"ended\" …" db.statement="\n\nUPDATE\n \"sessions\"\nSET\n \"ended\" = ?\nWHERE\n \"sessions\".\"id\" = ?\n" rows_affected=1 rows_returned=0 elapsed=5.933697ms
19:07:45 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=19.56µs
19:07:45 INFO summary="SELECT \"sessions\".\"id\", \"sessions\".\"target_snapshot\", \"sessions\".\"username\", …" db.statement="\n\nSELECT\n \"sessions\".\"id\",\n \"sessions\".\"target_snapshot\",\n \"sessions\".\"username\",\n \"sessions\".\"remote_address\",\n \"sessions\".\"started\",\n \"sessions\".\"ended\",\n \"sessions\".\"ticket_id\",\n \"sessions\".\"protocol\"\nFROM\n \"sessions\"\nWHERE\n \"sessions\".\"id\" = ?\nLIMIT\n ?\n" rows_affected=0 rows_returned=1 elapsed=213.56µs
19:07:45 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=16.24µs
19:07:45 INFO summary="INSERT INTO \"log\" (\"id\", …" db.statement="\n\nINSERT INTO\n \"log\" (\n \"id\",\n \"text\",\n \"values\",\n \"timestamp\",\n \"session_id\",\n \"username\"\n )\nVALUES\n (?, ?, ?, ?, ?, ?)\n" rows_affected=1 rows_returned=0 elapsed=6.129857ms
19:07:45 INFO summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=15.48µs
19:07:45 INFO summary="SELECT \"log\".\"id\", \"log\".\"text\", \"log\".\"values\", …" db.statement="\n\nSELECT\n \"log\".\"id\",\n \"log\".\"text\",\n \"log\".\"values\",\n \"log\".\"timestamp\",\n \"log\".\"session_id\",\n \"log\".\"username\"\nFROM\n \"log\"\nWHERE\n \"log\".\"id\" = ?\nLIMIT\n ?\n" rows_affected=0 rows_returned=1 elapsed=210.281µs
19:07:45 INFO summary="INSERT INTO \"log\" (\"id\", …" db.statement="\n\nINSERT INTO\n \"log\" (\n \"id\",\n \"text\",\n \"values\",\n \"timestamp\",\n \"session_id\",\n \"username\"\n )\nVALUES\n (?, ?, ?, ?, ?, ?)\n" rows_affected=1 rows_returned=0 elapsed=6.281058ms
19:07:45 INFO summary="SELECT \"log\".\"id\", \"log\".\"text\", \"log\".\"values\", …" db.statement="\n\nSELECT\n \"log\".\"id\",\n \"log\".\"text\",\n \"log\".\"values\",\n \"log\".\"timestamp\",\n \"log\".\"session_id\",\n \"log\".\"username\"\nFROM\n \"log\"\nWHERE\n \"log\".\"id\" = ?\nLIMIT\n ?\n" rows_affected=1 rows_returned=1 elapsed=125.641µs
Any idea why this is happening?
This is what Moba does when compression is enabled:
This is what Moba does when compression is disabled: