Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

flake.lock: Update #305

Merged
merged 1 commit into from
Sep 16, 2024

flake.lock: Update

5949ff2
Select commit
Loading
Failed to load commit list.
Merged

flake.lock: Update #305

flake.lock: Update
5949ff2
Select commit
Loading
Failed to load commit list.
Garnix CI / check vm_ldap_auth [x86_64-linux] succeeded Sep 16, 2024 in 5m 13s

Run results

Build succeeded

Details

Last 100 lines of logs:

�[2mserver # [   12.470134] lldap-start[957]: 2024-09-16T01:30:00.226959430+00:00  DEBUG    │  ┕━ 🐛 [debug]:  | return: []�[0m
�[2mserver # [   12.471116] lldap-start[957]: 2024-09-16T01:30:00.226972840+00:00  WARN     ┝━ 🚧 [warn]: Could not find an admin user, trying to create the user "admin" with the config-provided password�[0m
�[2mserver # [   12.472714] lldap-start[957]: 2024-09-16T01:30:00.234817133+00:00  DEBUG    ┝━ create_user [ 4.10ms | 1.45% ] request: CreateUserRequest { user_id: UserId(CaseInsensitiveString("admin")), email: Email("admin@example.com"), display_name: Some("Administrator"), first_name: None, last_name: None, avatar: None, attributes: [] } | user_id: "admin"�[0m
�[2mserver # [   12.475391] lldap-start[957]: 2024-09-16T01:30:00.265236083+00:00  DEBUG    ┝━ register_password [ 72.7ms | 22.99% / 25.76% ] username: admin�[0m
�[2mserver # [   12.476558] lldap-start[957]: 2024-09-16T01:30:00.265446445+00:00  DEBUG    │  ┝━ registration_start [ 504µs | 0.18% ]�[0m
�[2mserver # [   12.477648] lldap-start[957]: 2024-09-16T01:30:00.330580421+00:00  DEBUG    │  ┕━ registration_finish [ 7.32ms | 2.59% ]�[0m
�[2mserver # [   12.478677] lldap-start[957]: 2024-09-16T01:30:00.340619127+00:00  DEBUG    ┝━ list_groups [ 16.3ms | 5.79% ] filters: Some(DisplayName(GroupName("lldap_admin")))�[0m
�[2mserver # [   12.479992] lldap-start[957]: 2024-09-16T01:30:00.357269567+00:00  DEBUG    │  ┕━ 🐛 [debug]:  | return: [Group { id: GroupId(1), display_name: GroupName("lldap_admin"), creation_date: 2024-09-16T01:30:00.088705546, uuid: Uuid("68f04c8c-c6b8-3b56-9e77-8a6c0f4f0de4"), users: [], attributes: [] }]�[0m
�[2mserver # [   12.482219] lldap-start[957]: 2024-09-16T01:30:00.357526024+00:00  DEBUG    ┝━ add_user_to_group [ 744µs | 0.26% ] user_id: "admin"�[0m
�[2mserver # [   12.483274] lldap-start[957]: 2024-09-16T01:30:00.369399321+00:00  INFO     ┝━ i [info]: Starting the LDAP server on port 3890�[0m
�[2mserver # [   12.484317] lldap-start[957]: 2024-09-16T01:30:00.369674496+00:00  DEBUG    ┝━ get_jwt_blacklist [ 200µs | 0.07% ]�[0m
�[2mserver # [   12.485430] lldap-start[957]: 2024-09-16T01:30:00.370088515+00:00  INFO     ┕━ i [info]: Starting the API/web server on port 17170�[0m
�[2mserver # [   12.486788] lldap-start[957]: 2024-09-16T01:30:00.373658522+00:00  INFO     i [info]: starting 1 workers�[0m
�[2mserver # [   12.487863] lldap-start[957]: 2024-09-16T01:30:00.375770522+00:00  INFO     i [info]: Actix runtime found; starting in Actix runtime�[0m
�[2mserver # [   12.489187] lldap-start[957]: 2024-09-16T01:30:00.417223556+00:00  INFO     i [info]: DB Cleanup Cron started�[0m
(finished: waiting for unit lldap.service, in 13.03 seconds)
server: �[1m�[32mwaiting for TCP port 17170 on localhost�[0m
�[2mserver # Connection to localhost (127.0.0.1) 17170 port [tcp/*] succeeded!�[0m
(finished: waiting for TCP port 17170 on localhost, in 0.03 seconds)
�[1m�[32msubtest: fail without authenticating�[0m
client: �[1m�[32mmust fail: curl -f -s -X GET -H "Content-type: application/json"  -H "Host: ldap.example.com"  http://server/api/graphql�[0m
client: �[1m�[32mwaiting for the VM to finish booting�[0m
client: Guest shell says: b'Spawning backdoor root shell...\n'
client: connected to guest root shell
client: (connecting took 0.00 seconds)
(finished: waiting for the VM to finish booting, in 0.00 seconds)
�[2mserver # [   12.674153] lldap-start[957]: 2024-09-16T01:30:00.615023835+00:00  DEBUG    HTTP request [ 503µs | 100.00% ] method: "GET" | uri: "/api/graphql"�[0m
�[2mserver # [   12.675882] lldap-start[957]: 2024-09-16T01:30:00.615598768+00:00  ERROR    ┝━ 🚨 [error]:  | error: AuthenticationError { challenge: Bearer { scope: None, realm: None, error: None, error_description: None, error_uri: None }, status_code: 401 }�[0m
(finished: must fail: curl -f -s -X GET -H "Content-type: application/json"  -H "Host: ldap.example.com"  http://server/api/graphql, in 0.04 seconds)
(finished: subtest: fail without authenticating, in 0.04 seconds)
�[1m�[32msubtest: fail authenticating with wrong credentials�[0m
client: �[1m�[32mmust fail: curl -f -s -X POST -H "Content-type: application/json"  -H "Host: ldap.example.com"  http://server/auth/simple/login -d '{"username": "admin", "password": "wrong"}'�[0m
�[2mserver # [   12.677826] lldap-start[957]: 2024-09-16T01:30:00.615608546+00:00  WARN     ┕━ 🚧 [warn]: Error encountered while processing the incoming HTTP request: AuthenticationError { challenge: Bearer { scope: None, realm: None, error: None, error_description: None, error_uri: None }, status_code: 401 }�[0m
�[2mserver # [   12.699449] lldap-start[957]: 2024-09-16T01:30:00.641291978+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"users\".\"password_hash\" FROM \"users\" …" | db.statement: "\n\nSELECT\n  \"users\".\"password_hash\"\nFROM\n  \"users\"\nWHERE\n  \"users\".\"user_id\" = ?\nLIMIT\n  ?\n" | rows_affected: 1 | rows_returned: 1 | elapsed: 130.184µs�[0m
�[2mserver # [   12.762714] lldap-start[957]: 2024-09-16T01:30:00.640586022+00:00  DEBUG    HTTP request [ 63.9ms | 0.61% / 100.00% ] method: "POST" | uri: "/auth/simple/login"�[0m
�[2mserver # [   12.764349] lldap-start[957]: 2024-09-16T01:30:00.640944448+00:00  DEBUG    ┝━ simple_login [ 63.5ms | 0.19% / 99.39% ]�[0m
�[2mserver # [   12.765595] lldap-start[957]: 2024-09-16T01:30:00.640975457+00:00  DEBUG    │  ┕━ bind [ 63.4ms | 0.08% / 99.20% ]�[0m
�[2mserver # [   12.766744] lldap-start[957]: 2024-09-16T01:30:00.640992499+00:00  DEBUG    │     ┝━ get_password_file_for_user [ 3.05ms | 4.77% ] user_id: UserId(CaseInsensitiveString("admin"))�[0m
(finished: must fail: curl -f -s -X POST -H "Content-type: application/json"  -H "Host: ldap.example.com"  http://server/auth/simple/login -d '{"username": "admin", "password": "wrong"}', in 0.09 seconds)
(finished: subtest: fail authenticating with wrong credentials, in 0.09 seconds)
�[1m�[32msubtest: succeed with correct authentication�[0m
client: �[1m�[32mmust succeed: curl -f -s -X POST  -H "Content-type: application/json"  -H "Host: ldap.example.com"  http://server/auth/simple/login  -d '{"username": "admin", "password": "securepw"}' �[0m
�[2mserver # [   12.768222] lldap-start[957]: 2024-09-16T01:30:00.644058810+00:00  DEBUG    │     ┝━ passwords_match [ 60.3ms | 94.35% ] username: admin�[0m
�[2mserver # [   12.769439] lldap-start[957]: 2024-09-16T01:30:00.704334907+00:00  ERROR    │     │  ┕━ 🚨 [error]:  | error: Authentication protocol error for `Protocol error: `This error results from an error during password verification``�[0m
�[2mserver # [   12.771264] lldap-start[957]: 2024-09-16T01:30:00.704354183+00:00  DEBUG    │     ┝━ 🐛 [debug]: Invalid password for "admin": Authentication protocol error for `Protocol error: `This error results from an error during password verification``�[0m
�[2mserver # [   12.773265] lldap-start[957]: 2024-09-16T01:30:00.704359770+00:00  ERROR    │     ┕━ 🚨 [error]:  | error: Authentication error: ` for user 'admin'`�[0m
�[2mserver # [   12.774607] lldap-start[957]: 2024-09-16T01:30:00.704483808+00:00  DEBUG    ┕━ 🐛 [debug]:  | status_code: 401�[0m
�[2mserver # [   12.789817] lldap-start[957]: 2024-09-16T01:30:00.731664637+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"users\".\"password_hash\" FROM \"users\" …" | db.statement: "\n\nSELECT\n  \"users\".\"password_hash\"\nFROM\n  \"users\"\nWHERE\n  \"users\".\"user_id\" = ?\nLIMIT\n  ?\n" | rows_affected: 1 | rows_returned: 1 | elapsed: 117.054µs�[0m
�[2mserver # [   12.857571] lldap-start[957]: 2024-09-16T01:30:00.799205623+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"users\".\"user_id\", \"users\".\"email\", \"users\".\"lowercase_email\", …" | db.statement: "\n\nSELECT\n  \"users\".\"user_id\",\n  \"users\".\"email\",\n  \"users\".\"lowercase_email\",\n  \"users\".\"display_name\",\n  \"users\".\"creation_date\",\n  \"users\".\"password_hash\",\n  \"users\".\"totp_secret\",\n  \"users\".\"mfa_type\",\n  \"users\".\"uuid\"\nFROM\n  \"users\"\nWHERE\n  \"users\".\"user_id\" = ?\nLIMIT\n  ?\n" | rows_affected: 1 | rows_returned: 1 | elapsed: 140.52µs�[0m
�[2mserver # [   12.862748] lldap-start[957]: 2024-09-16T01:30:00.804606589+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"groups\".\"group_id\", \"groups\".\"display_name\", \"groups\".\"lowercase_display_name\", …" | db.statement: "\n\nSELECT\n  \"groups\".\"group_id\",\n  \"groups\".\"display_name\",\n  \"groups\".\"lowercase_display_name\",\n  \"groups\".\"creation_date\",\n  \"groups\".\"uuid\"\nFROM\n  \"groups\"\n  INNER JOIN \"memberships\" AS \"r0\" ON \"r0\".\"group_id\" = \"groups\".\"group_id\"\n  INNER JOIN \"users\" AS \"r1\" ON \"r1\".\"user_id\" = \"r0\".\"user_id\"\nWHERE\n  \"r1\".\"user_id\" = ?\n" | rows_affected: 1 | r…
�[2mserver # [   12.872496] lldap-start[957]: 2024-09-16T01:30:00.814187695+00:00  DEBUG    🐛 [debug]:  | summary: "INSERT INTO \"jwt_refresh_storage\" (\"refresh_token_hash\", …" | db.statement: "\n\nINSERT INTO\n  \"jwt_refresh_storage\" (\"refresh_token_hash\", \"user_id\", \"expiry_date\")\nVALUES\n  (?, ?, ?)\n" | rows_affected: 1 | rows_returned: 0 | elapsed: 2.809575ms�[0m
�[2mserver # [   12.876106] lldap-start[957]: 2024-09-16T01:30:00.817790108+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"jwt_refresh_storage\".\"refresh_token_hash\", \"jwt_refresh_storage\".\"user_id\", \"jwt_refresh_storage\".\"expiry_date\" …" | db.statement: "\n\nSELECT\n  \"jwt_refresh_storage\".\"refresh_token_hash\",\n  \"jwt_refresh_storage\".\"user_id\",\n  \"jwt_refresh_storage\".\"expiry_date\"\nFROM\n  \"jwt_refresh_storage\"\nWHERE\n  \"jwt_refresh_storage\".\"refresh_token_hash\" = ?\nLIMIT\n  ?\n" | rows_affected: 1 | rows_returned: 1 | elapsed: 77.384µs�[0m
�[2mserver # [   12.883118] lldap-start[957]: 2024-09-16T01:30:00.824743506+00:00  DEBUG    🐛 [debug]:  | summary: "INSERT INTO \"jwt_storage\" (\"jwt_hash\", …" | db.statement: "\n\nINSERT INTO\n  \"jwt_storage\" (\n    \"jwt_hash\",\n    \"user_id\",\n    \"expiry_date\",\n    \"blacklisted\"\n  )\nVALUES\n  (?, ?, ?, ?)\n" | rows_affected: 1 | rows_returned: 0 | elapsed: 2.386895ms�[0m
�[2mserver # [   12.885783] lldap-start[957]: 2024-09-16T01:30:00.824979570+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"jwt_storage\".\"jwt_hash\", \"jwt_storage\".\"user_id\", \"jwt_storage\".\"expiry_date\", …" | db.statement: "\n\nSELECT\n  \"jwt_storage\".\"jwt_hash\",\n  \"jwt_storage\".\"user_id\",\n  \"jwt_storage\".\"expiry_date\",\n  \"jwt_storage\".\"blacklisted\"\nFROM\n  \"jwt_storage\"\nWHERE\n  \"jwt_storage\".\"jwt_hash\" = ?\nLIMIT\n  ?\n" | rows_affected: 1 | rows_returned: 1 | elapsed: 100.012µs�[0m
�[2mserver # [   12.889810] lldap-start[957]: 2024-09-16T01:30:00.731303697+00:00  DEBUG    HTTP request [ 91.6ms | 0.12% / 100.00% ] method: "POST" | uri: "/auth/simple/login"�[0m
�[2mserver # [   12.891283] lldap-start[957]: 2024-09-16T01:30:00.731353145+00:00  DEBUG    ┝━ simple_login [ 91.5ms | 0.11% / 99.88% ]�[0m
�[2mserver # [   12.892316] lldap-start[957]: 2024-09-16T01:30:00.731373539+00:00  DEBUG    │  ┝━ bind [ 67.3ms | 0.05% / 73.46% ]�[0m
�[2mserver # [   12.893271] lldap-start[957]: 2024-09-16T01:30:00.731388345+00:00  DEBUG    │  │  ┝━ get_password_file_for_user [ 2.81ms | 3.07% ] user_id: UserId(CaseInsensitiveString("admin"))�[0m
(finished: must succeed: curl -f -s -X POST  -H "Content-type: application/json"  -H "Host: ldap.example.com"  http://server/auth/simple/login  -d '{"username": "admin", "password": "securepw"}' , in 0.13 seconds)
client: �[1m�[32mmust succeed: curl -f -s -X POST  -H "Content-type: application/json"  -H "Host: ldap.example.com"  -H "Authorization: Bearer eyJhbGciOiJIUzUxMiJ9.eyJleHAiOiIyMDI0LTA5LTE3VDAxOjMwOjAwLjgxNzg0MjM1MFoiLCJpYXQiOiIyMDI0LTA5LTE2VDAxOjMwOjAwLjgxNzg0NzM3OFoiLCJ1c2VyIjoiYWRtaW4iLCJncm91cHMiOlsibGxkYXBfYWRtaW4iXX0.-V3NI2XpTHJwjhp7qvpzs2o3UxEdqKumrwKVrasp1yXKPdO9Uo2V4VJEP6taI9QjO1h29DtXcWXtQDYCMNuBbQ"  http://server/api/graphql  -d '{"variables": {"id": "admin"}, "query":"query($id:String!){user(userId:$id){displayName groups{displayName}}}"}' �[0m
�[2mserver # [   12.894651] lldap-start[957]: 2024-09-16T01:30:00.734212168+00:00  DEBUG    │  │  ┕━ passwords_match [ 64.5ms | 70.35% ] username: admin�[0m
�[2mserver # [   12.895671] lldap-start[957]: 2024-09-16T01:30:00.798694385+00:00  DEBUG    │  ┕━ get_login_successful_response [ 24.1ms | 5.15% / 26.31% ]�[0m
�[2mserver # [   12.896790] lldap-start[957]: 2024-09-16T01:30:00.798841890+00:00  DEBUG    │     ┝━ get_user_groups [ 11.8ms | 12.90% ] user_id: "admin"�[0m
�[2mserver # [   12.897894] lldap-start[957]: 2024-09-16T01:30:00.810798438+00:00  DEBUG    │     │  ┕━ 🐛 [debug]:  | return: {GroupDetails { group_id: GroupId(1), display_name: GroupName("lldap_admin"), creation_date: 2024-09-16T01:30:00.088705546, uuid: Uuid("68f04c8c-c6b8-3b56-9e77-8a6c0f4f0de4"), attributes: [] }}�[0m
�[2mserver # [   12.900128] lldap-start[957]: 2024-09-16T01:30:00.810881130+00:00  DEBUG    │     ┝━ create_refresh_token [ 632µs | 0.69% ]�[0m
�[2mserver # [   12.901139] lldap-start[957]: 2024-09-16T01:30:00.810899009+00:00  DEBUG    │     │  ┕━ 🐛 [debug]:  | user: UserId(CaseInsensitiveString("admin"))�[0m
�[2mserver # [   12.902331] lldap-start[957]: 2024-09-16T01:30:00.821947061+00:00  DEBUG    │     ┕━ register_jwt [ 6.94ms | 7.57% ]�[0m
�[2mserver # [   12.903295] lldap-start[957]: 2024-09-16T01:30:00.821969410+00:00  DEBUG    │        ┕━ 🐛 [debug]:  | user: UserId(CaseInsensitiveString("admin")) | jwt_hash: 5097530389898270999�[0m
�[2mserver # [   12.904659] lldap-start[957]: 2024-09-16T01:30:00.831381780+00:00  DEBUG    ┕━ 🐛 [debug]:  | status_code: 200�[0m
�[2mserver # [   12.921981] lldap-start[957]: 2024-09-16T01:30:00.863814114+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"user_attribute_schema\".\"user_attribute_schema_name\", \"user_attribute_schema\".\"user_attribute_schema_type\", \"user_attribute_schema\".\"user_attribute_schema_is_list\", …" | db.statement: "\n\nSELECT\n  \"user_attribute_schema\".\"user_attribute_schema_name\",\n  \"user_attribute_schema\".\"user_attribute_schema_type\",\n  \"user_attribute_schema\".\"user_attribute_schema_is_list\",\n  \"user_attribute_schema\".\"user_attribute_schema_is_user_visible\",\n  \"user_attribute_schema\".\"user_attribute_schema_is_user…
�[2mserver # [   12.929177] lldap-start[957]: 2024-09-16T01:30:00.870803829+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"group_attribute_schema\".\"group_attribute_schema_name\", \"group_attribute_schema\".\"group_attribute_schema_type\", \"group_attribute_schema\".\"group_attribute_schema_is_list\", …" | db.statement: "\n\nSELECT\n  \"group_attribute_schema\".\"group_attribute_schema_name\",\n  \"group_attribute_schema\".\"group_attribute_schema_type\",\n  \"group_attribute_schema\".\"group_attribute_schema_is_list\",\n  \"group_attribute_schema\".\"group_attribute_schema_is_group_visible\",\n  \"group_attribute_schema\".\"group_attribu…
�[2mserver # [   12.935992] lldap-start[957]: 2024-09-16T01:30:00.870992401+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"user_object_classes\".\"lower_object_class\", \"user_object_classes\".\"object_class\" FROM …" | db.statement: "\n\nSELECT\n  \"user_object_classes\".\"lower_object_class\",\n  \"user_object_classes\".\"object_class\"\nFROM\n  \"user_object_classes\"\nORDER BY\n  \"user_object_classes\".\"object_class\" ASC\n" | rows_affected: 1 | rows_returned: 0 | elapsed: 62.019µs�[0m
�[2mserver # [   12.939844] lldap-start[957]: 2024-09-16T01:30:00.877708338+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"group_object_classes\".\"lower_object_class\", \"group_object_classes\".\"object_class\" FROM …" | db.statement: "\n\nSELECT\n  \"group_object_classes\".\"lower_object_class\",\n  \"group_object_classes\".\"object_class\"\nFROM\n  \"group_object_classes\"\nORDER BY\n  \"group_object_classes\".\"object_class\" ASC\n" | rows_affected: 1 | rows_returned: 0 | elapsed: 26.261µs�[0m
�[2mserver # [   12.943664] lldap-start[957]: 2024-09-16T01:30:00.885428872+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"users\".\"user_id\", \"users\".\"email\", \"users\".\"lowercase_email\", …" | db.statement: "\n\nSELECT\n  \"users\".\"user_id\",\n  \"users\".\"email\",\n  \"users\".\"lowercase_email\",\n  \"users\".\"display_name\",\n  \"users\".\"creation_date\",\n  \"users\".\"password_hash\",\n  \"users\".\"totp_secret\",\n  \"users\".\"mfa_type\",\n  \"users\".\"uuid\"\nFROM\n  \"users\"\nWHERE\n  \"users\".\"user_id\" = ?\nLIMIT\n  ?\n" | rows_affected: 1 | rows_returned: 1 | elapsed: 52.521µs�[0m
�[2mserver # [   12.948399] lldap-start[957]: 2024-09-16T01:30:00.890118854+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"user_attributes\".\"user_attribute_user_id\", \"user_attributes\".\"user_attribute_name\", \"user_attributes\".\"user_attribute_value\" …" | db.statement: "\n\nSELECT\n  \"user_attributes\".\"user_attribute_user_id\",\n  \"user_attributes\".\"user_attribute_name\",\n  \"user_attributes\".\"user_attribute_value\"\nFROM\n  \"user_attributes\"\nWHERE\n  \"user_attributes\".\"user_attribute_user_id\" = ?\nORDER BY\n  \"user_attributes\".\"user_attribute_name\" ASC\n" | rows_affected: 1 | rows_returned: 0 | elapsed: 92.191µ…
�[2mserver # [   12.954070] lldap-start[957]: 2024-09-16T01:30:00.895820137+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"users\".\"user_id\", \"users\".\"email\", \"users\".\"lowercase_email\", …" | db.statement: "\n\nSELECT\n  \"users\".\"user_id\",\n  \"users\".\"email\",\n  \"users\".\"lowercase_email\",\n  \"users\".\"display_name\",\n  \"users\".\"creation_date\",\n  \"users\".\"password_hash\",\n  \"users\".\"totp_secret\",\n  \"users\".\"mfa_type\",\n  \"users\".\"uuid\"\nFROM\n  \"users\"\nWHERE\n  \"users\".\"user_id\" = ?\nLIMIT\n  ?\n" | rows_affected: 1 | rows_returned: 1 | elapsed: 91.073µs�[0m
�[2mserver # [   12.959122] lldap-start[957]: 2024-09-16T01:30:00.900802893+00:00  DEBUG    🐛 [debug]:  | summary: "SELECT \"groups\".\"group_id\", \"groups\".\"display_name\", \"groups\".\"lowercase_display_name\", …" | db.statement: "\n\nSELECT\n  \"groups\".\"group_id\",\n  \"groups\".\"display_name\",\n  \"groups\".\"lowercase_display_name\",\n  \"groups\".\"creation_date\",\n  \"groups\".\"uuid\"\nFROM\n  \"groups\"\n  INNER JOIN \"memberships\" AS \"r0\" ON \"r0\".\"group_id\" = \"groups\".\"group_id\"\n  INNER JOIN \"users\" AS \"r1\" ON \"r1\".\"user_id\" = \"r0\".\"user_id\"\nWHERE\n  \"r1\".\"user_id\" = ?\n" | rows_affected: 1 | r…
�[2mserver # [   12.965061] lldap-start[957]: 2024-09-16T01:30:00.859115752+00:00  DEBUG    HTTP request [ 33.4ms | 32.68% / 100.00% ] method: "POST" | uri: "/api/graphql"�[0m
�[2mserver # [   12.966556] lldap-start[957]: 2024-09-16T01:30:00.859266050+00:00  DEBUG    ┝━ check_if_token_is_valid [ 256µs | 0.77% ]�[0m
(finished: must succeed: curl -f -s -X POST  -H "Content-type: application/json"  -H "Host: ldap.example.com"  -H "Authorization: Bearer eyJhbGciOiJIUzUxMiJ9.eyJleHAiOiIyMDI0LTA5LTE3VDAxOjMwOjAwLjgxNzg0MjM1MFoiLCJpYXQiOiIyMDI0LTA5LTE2VDAxOjMwOjAwLjgxNzg0NzM3OFoiLCJ1c2VyIjoiYWRtaW4iLCJncm91cHMiOlsibGxkYXBfYWRtaW4iXX0.-V3NI2XpTHJwjhp7qvpzs2o3UxEdqKumrwKVrasp1yXKPdO9Uo2V4VJEP6taI9QjO1h29DtXcWXtQDYCMNuBbQ"  http://server/api/graphql  -d '{"variables": {"id": "admin"}, "query":"query($id:String!){user(userId:$id){displayName groups{displayName}}}"}' , in 0.08 seconds)
�[2mserver # [   12.967741] lldap-start[957]: 2024-09-16T01:30:00.859525580+00:00  DEBUG    │  ┕━ 🐛 [debug]:  | return: ValidationResults { user: UserId(CaseInsensitiveString("admin")), permission: Admin }�[0m
(finished: subtest: succeed with correct authentication, in 0.20 seconds)
�[2mserver # [   12.969379] lldap-start[957]: 2024-09-16T01:30:00.863269632+00:00  DEBUG    ┝━ [GraphQL query] user [ 17.7ms | 2.67% / 52.87% ]�[0m
(finished: run the VM test script, in 13.65 seconds)
�[2mserver # [   12.970451] lldap-start[957]: 2024-09-16T01:30:00.863282762+00:00  DEBUG    │  ┝━ 🐛 [debug]:  | user_id: "admin"�[0m
�[2mserver # [   12.971415] lldap-start[957]: 2024-09-16T01:30:00.878058103+00:00  DEBUG    │  ┕━ get_user_details [ 16.8ms | 50.19% ] user_id: "admin"�[0m
�[2mserver # [   12.972571] lldap-start[957]: 2024-09-16T01:30:00.894842080+00:00  DEBUG    │     ┕━ 🐛 [debug]:  | return: Ok(User { user_id: UserId(CaseInsensitiveString("admin")), email: Email("admin@example.com"), display_name: Some("Administrator"), creation_date: 2024-09-16T01:30:00.234828587, uuid: Uuid("0fe5e8ec-333c-3957-abf0-6df66ae3058b"), attributes: [] })�[0m
�[2mserver # [   12.975350] lldap-start[957]: 2024-09-16T01:30:00.895522055+00:00  DEBUG    ┝━ [GraphQL query] user::groups [ 4.57ms | 0.16% / 13.68% ]�[0m
�[2mserver # [   12.976532] lldap-start[957]: 2024-09-16T01:30:00.895535744+00:00  DEBUG    │  ┝━ 🐛 [debug]:  | user_id: UserId(CaseInsensitiveString("admin"))�[0m
�[2mserver # [   12.977769] lldap-start[957]: 2024-09-16T01:30:00.895550550+00:00  DEBUG    │  ┕━ get_user_groups [ 4.52ms | 13.52% ] user_id: "admin"�[0m
�[2mserver # [   12.978953] lldap-start[957]: 2024-09-16T01:30:00.900864074+00:00  DEBUG    │     ┕━ 🐛 [debug]:  | return: {GroupDetails { group_id: GroupId(1), display_name: GroupName("lldap_admin"), creation_date: 2024-09-16T01:30:00.088705546, uuid: Uuid("68f04c8c-c6b8-3b56-9e77-8a6c0f4f0de4"), attributes: [] }}�[0m
�[2mserver # [   12.981316] lldap-start[957]: 2024-09-16T01:30:00.906755885+00:00  DEBUG    ┕━ 🐛 [debug]:  | status_code: 200�[0m
test script finished in 13.70s
�[1m�[32mcleanup�[0m
kill machine (pid 8)
qemu-kvm: terminating on signal 15 from pid 5 (/nix/store/h3i0acpmr8mrjx07519xxmidv8mpax4y-python3-3.12.5/bin/python3.12)
kill machine (pid 29)
qemu-kvm: terminating on signal 15 from pid 5 (/nix/store/h3i0acpmr8mrjx07519xxmidv8mpax4y-python3-3.12.5/bin/python3.12)
(finished: cleanup, in 0.02 seconds)
kill vlan (pid 6)