Access Forbidden Error on Mobile View for "Tickets from my Organization" in Zammad 6.1.x

Bzaid94 · November 28, 2023, 10:23pm

Infos:

Used Zammad version: 6.1.x
Used Zammad installation type: (source, package, docker-compose, …)
Operating system: (operating system on which you run Zammad)
Browser + version: (browser and version used when experiencing the issue)

Expected behavior:

Clients should be able to access and view the “Tickets from my organization” section without any issues in both desktop and mobile views.

Actual behavior:

When accessing the “Tickets from my organization” section via a mobile view, an error is encountered in the network request to the GraphQL endpoint. The error does not occur in the desktop view for the same user and section.

The error received in the mobile view is as follows:

[
{
"data": null,
"errors": [
{
"message": "Access forbidden by Gql::Types::GroupType",
"locations": [
{
"line": 44,
"column": 9
}
],
"path": [
"ticketsByOverview",
"edges",
1,
"node",
"group"
],
"extensions": {
"type": "Exceptions::Forbidden"
}
}
]
}
]

In contrast, the desktop view responds correctly with the expected ticket information.

Steps to reproduce the behavior:

Log in as a client on the Zammad mobile view.
Navigate to the “Tickets from my organization” section.
Observe the error in the network request as mentioned above.
Log in as the same client on the Zammad desktop view.
Navigate to the “Tickets from my organization” section and observe the correct response.

Additional information:

The issue seems to be related to the GraphQL API’s permissions when accessed via mobile.

In APP Version:

In Desktop Version:

dominikklein · November 29, 2023, 7:51am

I’m not able to reproduce the problem.

I think we need some more information about the tickets. For example is it a shared organization and there are also tickets from other customer users from this organization?
Is it a user who has only the “customer” role or more?

Bzaid94 · November 29, 2023, 2:42pm

The organizations in our Zammad setup are configured as “shared”, meaning multiple customer users are associated with each organization.
The users experiencing the issue are assigned only the “customer” role within Zammad.
The problem specifically occurs when these users attempt to view “Tickets from my organization” while on the mobile view. In this scenario, no tickets are displayed, and a GraphQL error is returned (as previously detailed in the bug report).
However, when accessing the same section from the desktop view as the same customer user, the tickets are displayed correctly without any errors.

This discrepancy between the mobile and desktop views suggests that there might be a mobile-specific issue with permissions or the GraphQL API call. The desktop view functions as expected for the same users under identical conditions.

Same user customer in app version

Same customer user in desktop

fliebe92 · November 30, 2023, 7:53am

Hi @Bzaid94. I just tested it and it works fine for me. Please share some screenshots of the customer role, the mentioned user (if needed, please redact some values), and the related organization(s).

The production.log might be interesting as well when trying to open such a ticket in the mobile view.

wagner.loch · October 21, 2024, 10:00pm

Hello Guys,

We are facing the same issue here…

After some troubleshooting, we found that this issue occurs for Overviews that were edited or cloned.

A workarround was give admin permission to groups to Role: Customer

How can I deep dive to this issue?

MrGeneration · October 21, 2024, 11:02pm

With version 6.1.x? If so, update asap.

wagner.loch · October 22, 2024, 12:00am

Thank you, @MrGeneration, for your reply. We are using version 6.3.x and are working within a maintenance window to update, regarding security issue…

We have a testing instance updated to 6.3.1, and we faced the same issue there.

Thanks in advanced.

MrGeneration · October 22, 2024, 12:23am

Would you mind copy pasting the exact overview name to this board? Possibly with it’s configuration if it doesn’t contain sensitive information? That might help.

wagner.loch · October 22, 2024, 1:20am

Sure!

In this case I’m testing with default: My Organization Tickets

fliebe92 · October 22, 2024, 7:42pm

Hi @wagner.loch. What happens if you open this overview in the regular desktop view in Zammad? Maybe you can post a screenshot when no sensitive data is shown there.

Do you have any log information available when this issue appears in the mobile view? This might help us to debug it.

Setting.get('customer_ticket_create_group_ids') might also be interesting. If you’re using a package install: zammad run rails r "Setting.get('customer_ticket_create_group_ids')"

wagner.loch · October 22, 2024, 8:45pm

Hello @fliebe92, thank you for helping us!

On a regular desktop, it loads as expected.

As requested follow the output for Setting.get('customer_ticket_create_group_ids'):

[2] pry(main)> Setting.get('customer_ticket_create_group_ids') 
=> ["4", "9"]
[3] pry(main)>

Below is the response from the server:

[
    {
        "errors": [
            {
                "message": "Access forbidden by Gql::Types::GroupType",
                "locations": [
                    {
                        "line": 44,
                        "column": 9
                    }
                ],
                "path": [
                    "ticketsByOverview",
                    "edges",
                    0,
                    "node",
                    "group"
                ],
                "extensions": {
                    "type": "Exceptions::Forbidden"
                }
            }
        ],
        "data": null
    },
    {
        "data": {
            "ticketOverviews": {
                "edges": [
                    {
                        "node": {
                            "id": "gid://zammad/Overview/39",
                            "ticketCount": 0,
                            "__typename": "Overview"
                        },
                        "cursor": "MQ",
                        "__typename": "OverviewEdge"
                    },
                    {
                        "node": {
                            "id": "gid://zammad/Overview/10",
                            "ticketCount": 9,
                            "__typename": "Overview"
                        },
                        "cursor": "Mg",
                        "__typename": "OverviewEdge"
                    },
                    {
                        "node": {
                            "id": "gid://zammad/Overview/55",
                            "ticketCount": 9,
                            "__typename": "Overview"
                        },
                        "cursor": "Mw",
                        "__typename": "OverviewEdge"
                    },
                    {
                        "node": {
                            "id": "gid://zammad/Overview/57",
                            "ticketCount": 9,
                            "__typename": "Overview"
                        },
                        "cursor": "NA",
                        "__typename": "OverviewEdge"
                    },
                    {
                        "node": {
                            "id": "gid://zammad/Overview/58",
                            "ticketCount": 9,
                            "__typename": "Overview"
                        },
                        "cursor": "NQ",
                        "__typename": "OverviewEdge"
                    }
                ],
                "pageInfo": {
                    "endCursor": "NQ",
                    "hasNextPage": false,
                    "__typename": "PageInfo"
                },
                "__typename": "OverviewConnection"
            }
        }
    }
]```


 Thanks in advance.

fliebe92 · October 23, 2024, 6:46am

Hi @wagner.loch. Thanks for the information.

Do you have an excerpt of the production.log when this error occurs?

wagner.loch · October 23, 2024, 1:01pm

Hi @fliebe92,

I did not find any exceptions in the logs.

I’ve enabled debug, follow some logs:

I, [2024-10-23T09:45:35.134857#1553560-150440]  INFO -- : Started POST "/graphql" for <REMOVED IP BY PRIVACY> at 2024-10-23 09:45:35 -0300
D, [2024-10-23T09:45:35.138733#1553560-150440] DEBUG -- :   Setting Pluck (1.0ms)  SELECT "settings"."updated_at" FROM "settings" ORDER BY "settings"."updated_at" DESC LIMIT $1  [["LIMIT", 1]]
D, [2024-10-23T09:45:35.140319#1553560-150440] DEBUG -- :   Setting Pluck (0.8ms)  SELECT "settings"."name", "settings"."state_current" FROM "settings" WHERE (updated_at >= '2024-10-05 19:49:05.754000') ORDER BY "settings"."id" ASC
I, [2024-10-23T09:45:35.146774#1553560-150440]  INFO -- : Processing by GraphqlController#execute as */*
I, [2024-10-23T09:45:35.146907#1553560-150440]  INFO -- :   Parameters: {"_json"=>[{"operationName"=>"ticketsByOverview", "variables"=>{"pageSize"=>10, "withObjectAttributes"=>false, "overviewId"=>"gid://zammad/Overview/10", "orderBy"=>"created_at", "orderDirection"=>"DESCENDING", "showUpdatedBy"=>false, "showPriority"=>false}, "query"=>"query ticketsByOverview($overviewId: ID!, $orderBy: String, $orderDirection: EnumOrderDirection, $cursor: String, $showPriority: Boolean!, $showUpdatedBy: Boolean!, $pageSize: Int = 10, $withObjectAttributes: Boolean = false) {\n  ticketsByOverview(\n    overviewId: $overviewId\n    orderBy: $orderBy\n    orderDirection: $orderDirection\n    after: $cursor\n    first: $pageSize\n  ) {\n    totalCount\n    edges {\n      node {\n        id\n        internalId\n        number\n        title\n        createdAt\n        updatedAt\n        updatedBy @include(if: $showUpdatedBy) {\n          id\n          fullname\n          __typename\n        }\n        customer {\n          id\n          firstname\n          lastname\n          fullname\n          __typename\n        }\n        organization {\n          id\n          name\n          __typename\n        }\n        state {\n          id\n          name\n          stateType {\n            name\n            __typename\n          }\n          __typename\n        }\n        group {\n          id\n          name\n          __typename\n        }\n        priority @include(if: $showPriority) {\n          id\n          name\n          uiColor\n          defaultCreate\n          __typename\n        }\n        objectAttributeValues @include(if: $withObjectAttributes) {\n          ...objectAttributeValues\n          __typename\n        }\n        stateColorCode\n        __typename\n      }\n      cursor\n      __typename\n    }\n    pageInfo {\n      endCursor\n      hasNextPage\n      __typename\n    }\n    __typename\n  }\n}\n\nfragment objectAttributeValues on ObjectAttributeValue {\n  attribute {\n    name\n    display\n    __typename\n  }\n  value\n  renderedLink\n  __typename\n}"}, {"operationName"=>"ticketOverviewTicketCount", "variables"=>{}, "query"=>"query ticketOverviewTicketCount {\n  ticketOverviews {\n    edges {\n      node {\n        id\n        ticketCount\n        __typename\n      }\n      cursor\n      __typename\n    }\n    pageInfo {\n      endCursor\n      hasNextPage\n      __typename\n    }\n    __typename\n  }\n}"}]}
D, [2024-10-23T09:45:35.147101#1553560-150440] DEBUG -- : session based auth check
D, [2024-10-23T09:45:35.148121#1553560-150440] DEBUG -- :   User Load (0.6ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.148794#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.152264#1553560-150440] DEBUG -- :   Permission Pluck (0.9ms)  SELECT "permissions"."name" FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3  [["user_id", 922], ["active", true], ["active", true]]
D, [2024-10-23T09:45:35.154858#1553560-150440] DEBUG -- :   Permission Pluck (1.2ms)  SELECT "permissions"."name" FROM "permissions" WHERE (permissions.active = TRUE AND (permissions.name = 'user_preferences.password' OR permissions.name LIKE 'user\_preferences.password.%' OR permissions.name = 'user_preferences.language' OR permissions.name LIKE 'user\_preferences.language.%' OR permissions.name = 'user_preferences.linked_accounts' OR permissions.name LIKE 'user\_preferences.linked\_accounts.%' OR permissions.name = 'user_preferences.avatar' OR permissions.name LIKE 'user\_preferences.avatar.%' OR permissions.name = 'user_preferences.appearance' OR permissions.name LIKE 'user\_preferences.appearance.%' OR permissions.name = 'ticket.customer' OR permissions.name LIKE 'ticket.customer.%'))
D, [2024-10-23T09:45:35.156200#1553560-150440] DEBUG -- :   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = $1 LIMIT $2  [["name", "user_preferences.device"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.160386#1553560-150440] DEBUG -- :   Permission Exists? (1.2ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND "permissions"."name" IN ($4, $5) LIMIT $6  [["user_id", 922], ["active", true], ["active", true], ["name", "user_preferences"], ["name", "user_preferences.device"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.160676#1553560-150440] DEBUG -- : session for '<EMAIL USER REMOVED BY PRIVACY>'
D, [2024-10-23T09:45:35.161460#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.164274#1553560-150440] DEBUG -- :   CACHE Permission Pluck (0.0ms)  SELECT "permissions"."name" FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3  [["user_id", 922], ["active", true], ["active", true]]
D, [2024-10-23T09:45:35.165216#1553560-150440] DEBUG -- :   CACHE Permission Pluck (0.0ms)  SELECT "permissions"."name" FROM "permissions" WHERE (permissions.active = TRUE AND (permissions.name = 'user_preferences.password' OR permissions.name LIKE 'user\_preferences.password.%' OR permissions.name = 'user_preferences.language' OR permissions.name LIKE 'user\_preferences.language.%' OR permissions.name = 'user_preferences.linked_accounts' OR permissions.name LIKE 'user\_preferences.linked\_accounts.%' OR permissions.name = 'user_preferences.avatar' OR permissions.name LIKE 'user\_preferences.avatar.%' OR permissions.name = 'user_preferences.appearance' OR permissions.name LIKE 'user\_preferences.appearance.%' OR permissions.name = 'ticket.customer' OR permissions.name LIKE 'ticket.customer.%'))
D, [2024-10-23T09:45:35.179997#1553560-150440] DEBUG -- :   Overview Load (0.8ms)  SELECT "overviews".* FROM "overviews" WHERE "overviews"."id" = $1 LIMIT $2  [["id", 10], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.181250#1553560-150440] DEBUG -- :   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = $1 LIMIT $2  [["name", "admin.overview"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.183529#1553560-150440] DEBUG -- :   Permission Exists? (1.2ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND "permissions"."name" IN ($4, $5) LIMIT $6  [["user_id", 922], ["active", true], ["active", true], ["name", "admin"], ["name", "admin.overview"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.185027#1553560-150440] DEBUG -- :   Role Pluck (0.5ms)  SELECT "roles"."id" FROM "roles" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1  [["user_id", 922]]
D, [2024-10-23T09:45:35.186605#1553560-150440] DEBUG -- :   Role Pluck (0.5ms)  SELECT "roles"."id" FROM "roles" INNER JOIN "overviews_roles" ON "roles"."id" = "overviews_roles"."role_id" WHERE "overviews_roles"."overview_id" = $1  [["overview_id", 10]]
D, [2024-10-23T09:45:35.187973#1553560-150440] DEBUG -- :   User Pluck (0.5ms)  SELECT "users"."id" FROM "users" INNER JOIN "overviews_users" ON "users"."id" = "overviews_users"."user_id" WHERE "overviews_users"."overview_id" = $1  [["overview_id", 10]]
D, [2024-10-23T09:45:35.189483#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.191179#1553560-150440] DEBUG -- :   Organization Pluck (0.4ms)  SELECT "organizations"."id" FROM "organizations" INNER JOIN "organizations_users" ON "organizations"."id" = "organizations_users"."organization_id" WHERE "organizations_users"."user_id" = $1 ORDER BY "organizations"."id" ASC  [["user_id", 922]]
D, [2024-10-23T09:45:35.192537#1553560-150440] DEBUG -- :   ObjectLookup Load (0.5ms)  SELECT "object_lookups".* FROM "object_lookups" WHERE "object_lookups"."name" = $1 LIMIT $2  [["name", "Ticket"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.193967#1553560-150440] DEBUG -- :    (0.8ms)  SELECT COUNT(*) AS "size", MAX("object_manager_attributes"."updated_at") AS timestamp FROM "object_manager_attributes" WHERE "object_manager_attributes"."active" = $1 AND "object_manager_attributes"."editable" = $2 AND "object_manager_attributes"."object_lookup_id" = $3  [["active", true], ["editable", true], ["object_lookup_id", 1]]
D, [2024-10-23T09:45:35.195887#1553560-150440] DEBUG -- :   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = $1 LIMIT $2  [["name", "ticket.agent"], ["LIMIT", 1]]

wagner.loch · October 23, 2024, 1:02pm

D, [2024-10-23T09:45:35.198032#1553560-150440] DEBUG -- :   Permission Exists? (1.1ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND "permissions"."name" IN ($4, $5) LIMIT $6  [["user_id", 922], ["active", true], ["active", true], ["name", "ticket"], ["name", "ticket.agent"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.198928#1553560-150440] DEBUG -- :   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = $1 LIMIT $2  [["name", "ticket.customer"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.200859#1553560-150440] DEBUG -- :   Permission Exists? (1.0ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND "permissions"."name" IN ($4, $5) LIMIT $6  [["user_id", 922], ["active", true], ["active", true], ["name", "ticket"], ["name", "ticket.customer"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.201968#1553560-150440] DEBUG -- :   CACHE Organization Pluck (0.0ms)  SELECT "organizations"."id" FROM "organizations" INNER JOIN "organizations_users" ON "organizations"."id" = "organizations_users"."organization_id" WHERE "organizations_users"."user_id" = $1 ORDER BY "organizations"."id" ASC  [["user_id", 922]]
D, [2024-10-23T09:45:35.203457#1553560-150440] DEBUG -- :   Organization Load (0.6ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" IN ($1, $2) ORDER BY "organizations"."id" ASC  [["id", 2], ["id", 132]]
D, [2024-10-23T09:45:35.204682#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" IN ($1, $2) ORDER BY "organizations"."id" ASC  [["id", 2], ["id", 132]]
D, [2024-10-23T09:45:35.207306#1553560-150440] DEBUG -- :   Ticket Count (1.8ms)  SELECT COUNT(*) FROM (SELECT DISTINCT "tickets".* FROM "tickets" WHERE (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) AND ((("tickets"."state_id" IN ('11','2','1','7','3')) AND ("tickets"."organization_id" IN (2,132)))) AND (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) ORDER BY "tickets"."state_id", "tickets"."created_at" DESC LIMIT $1) subquery_for_count  [["LIMIT", 2000]]
D, [2024-10-23T09:45:35.209120#1553560-150440] DEBUG -- :   Ticket Load (1.3ms)  SELECT DISTINCT "tickets".* FROM "tickets" WHERE (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) AND ((("tickets"."state_id" IN ('11','2','1','7','3')) AND ("tickets"."organization_id" IN (2,132)))) AND (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) ORDER BY "tickets"."state_id", "tickets"."created_at" DESC LIMIT $1 OFFSET $2  [["LIMIT", 10], ["OFFSET", 0]]
D, [2024-10-23T09:45:35.211427#1553560-150440] DEBUG -- :   Organization Load (0.5ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.214477#1553560-150440] DEBUG -- :   Ticket::State Load (0.5ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.215845#1553560-150440] DEBUG -- :   Ticket::StateType Load (0.5ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.217352#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.219210#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.219864#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.221097#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.222745#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.223347#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.224640#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.226303#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.227178#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.228384#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.230004#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.230598#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.231842#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.233440#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.234043#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.235608#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.237224#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.237858#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.239038#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.240734#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.241336#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.242555#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC LIMIT $2  [["id", 132], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.244180#1553560-150440] DEBUG -- :   CACHE Ticket::State Load (0.0ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.244860#1553560-150440] DEBUG -- :   CACHE Ticket::StateType Load (0.0ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1 LIMIT $2  [["id", 1], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.248437#1553560-150440] DEBUG -- :   Permission Exists? (1.4ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND "permissions"."name" IN ($4, $5, $6) LIMIT $7  [["user_id", 922], ["active", true], ["active", true], ["name", "ticket"], ["name", "ticket.customer"], ["name", "ticket.agent"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.250288#1553560-150440] DEBUG -- :   Organization Exists? (0.6ms)  SELECT 1 AS one FROM "organizations" WHERE "organizations"."id" IN ($1, $2) AND "organizations"."shared" = $3 LIMIT $4  [["id", 2], ["id", 132], ["shared", true], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.251876#1553560-150440] DEBUG -- :   User Exists? (0.7ms)  SELECT 1 AS one FROM "users" WHERE "users"."active" = $1 AND "users"."out_of_office" = $2 AND "users"."out_of_office_replacement_id" = $3 AND (out_of_office_start_at <= '2024-10-23' AND out_of_office_end_at >= '2024-10-23') LIMIT $4  [["active", true], ["out_of_office", true], ["out_of_office_replacement_id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.256818#1553560-150440] DEBUG -- :   Overview Load (3.1ms)  SELECT DISTINCT "overviews".* FROM "overviews" INNER JOIN "overviews_roles" ON "overviews_roles"."overview_id" = "overviews"."id" INNER JOIN "roles" ON "roles"."id" = "overviews_roles"."role_id" INNER JOIN "roles_users" ON "roles_users"."role_id" = "roles"."id" INNER JOIN "users" ON "users"."id" = "roles_users"."user_id" LEFT OUTER JOIN "overviews_users" ON "overviews_users"."overview_id" = "overviews"."id" LEFT OUTER JOIN "users" "users_overviews" ON "users_overviews"."id" = "overviews_users"."user_id" WHERE "overviews"."active" = $1 AND "roles"."active" = $2 AND "users"."id" = $3 AND "users"."active" = $4 AND ("overviews_users"."user_id" = $5 OR "overviews_users"."user_id" IS NULL) AND "overviews"."out_of_office" != $6 ORDER BY "overviews"."prio" ASC, "overviews"."name" ASC LIMIT $7 OFFSET $8  [["active", true], ["active", true], ["id", 922], ["active", true], ["user_id", 922], ["out_of_office", true], ["LIMIT", 100], ["OFFSET", 0]]
D, [2024-10-23T09:45:35.258956#1553560-150440] DEBUG -- :   Role Pluck (0.6ms)  SELECT "roles"."id" FROM "roles" INNER JOIN "overviews_roles" ON "roles"."id" = "overviews_roles"."role_id" WHERE "overviews_roles"."overview_id" = $1  [["overview_id", 39]]
D, [2024-10-23T09:45:35.260358#1553560-150440] DEBUG -- :   User Pluck (0.5ms)  SELECT "users"."id" FROM "users" INNER JOIN "overviews_users" ON "users"."id" = "overviews_users"."user_id" WHERE "overviews_users"."overview_id" = $1  [["overview_id", 39]]
D, [2024-10-23T09:45:35.261475#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.262764#1553560-150440] DEBUG -- :   CACHE Organization Pluck (0.0ms)  SELECT "organizations"."id" FROM "organizations" INNER JOIN "organizations_users" ON "organizations"."id" = "organizations_users"."organization_id" WHERE "organizations_users"."user_id" = $1 ORDER BY "organizations"."id" ASC  [["user_id", 922]]
D, [2024-10-23T09:45:35.264093#1553560-150440] DEBUG -- :   CACHE  (0.0ms)  SELECT COUNT(*) AS "size", MAX("object_manager_attributes"."updated_at") AS timestamp FROM "object_manager_attributes" WHERE "object_manager_attributes"."active" = $1 AND "object_manager_attributes"."editable" = $2 AND "object_manager_attributes"."object_lookup_id" = $3  [["active", true], ["editable", true], ["object_lookup_id", 1]]
D, [2024-10-23T09:45:35.265662#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" IN ($1, $2) ORDER BY "organizations"."id" ASC  [["id", 2], ["id", 132]]
D, [2024-10-23T09:45:35.268100#1553560-150440] DEBUG -- :   Ticket Count (1.6ms)  SELECT COUNT(*) FROM (SELECT DISTINCT "tickets".* FROM "tickets" WHERE (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) AND ((("tickets"."state_id" IN ('12','4','8','7')) AND ("tickets"."organization_id" IN (2,132)))) ORDER BY "tickets"."organization_id", "tickets"."created_at" DESC) subquery_for_count
D, [2024-10-23T09:45:35.269510#1553560-150440] DEBUG -- :   CACHE Role Pluck (0.0ms)  SELECT "roles"."id" FROM "roles" INNER JOIN "overviews_roles" ON "roles"."id" = "overviews_roles"."role_id" WHERE "overviews_roles"."overview_id" = $1  [["overview_id", 10]]
D, [2024-10-23T09:45:35.270333#1553560-150440] DEBUG -- :   CACHE User Pluck (0.0ms)  SELECT "users"."id" FROM "users" INNER JOIN "overviews_users" ON "users"."id" = "overviews_users"."user_id" WHERE "overviews_users"."overview_id" = $1  [["overview_id", 10]]
D, [2024-10-23T09:45:35.271260#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.272421#1553560-150440] DEBUG -- :   CACHE Organization Pluck (0.0ms)  SELECT "organizations"."id" FROM "organizations" INNER JOIN "organizations_users" ON "organizations"."id" = "organizations_users"."organization_id" WHERE "organizations_users"."user_id" = $1 ORDER BY "organizations"."id" ASC  [["user_id", 922]]
D, [2024-10-23T09:45:35.273728#1553560-150440] DEBUG -- :   CACHE  (0.0ms)  SELECT COUNT(*) AS "size", MAX("object_manager_attributes"."updated_at") AS timestamp FROM "object_manager_attributes" WHERE "object_manager_attributes"."active" = $1 AND "object_manager_attributes"."editable" = $2 AND "object_manager_attributes"."object_lookup_id" = $3  [["active", true], ["editable", true], ["object_lookup_id", 1]]
D, [2024-10-23T09:45:35.275140#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" IN ($1, $2) ORDER BY "organizations"."id" ASC  [["id", 2], ["id", 132]]
D, [2024-10-23T09:45:35.277215#1553560-150440] DEBUG -- :   Ticket Count (1.3ms)  SELECT COUNT(*) FROM (SELECT DISTINCT "tickets".* FROM "tickets" WHERE (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) AND ((("tickets"."state_id" IN ('11','2','1','7','3')) AND ("tickets"."organization_id" IN (2,132)))) ORDER BY "tickets"."state_id", "tickets"."created_at" DESC) subquery_for_count
D, [2024-10-23T09:45:35.278981#1553560-150440] DEBUG -- :   Role Pluck (0.5ms)  SELECT "roles"."id" FROM "roles" INNER JOIN "overviews_roles" ON "roles"."id" = "overviews_roles"."role_id" WHERE "overviews_roles"."overview_id" = $1  [["overview_id", 55]]
D, [2024-10-23T09:45:35.280275#1553560-150440] DEBUG -- :   User Pluck (0.4ms)  SELECT "users"."id" FROM "users" INNER JOIN "overviews_users" ON "users"."id" = "overviews_users"."user_id" WHERE "overviews_users"."overview_id" = $1  [["overview_id", 55]]
D, [2024-10-23T09:45:35.281185#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.282633#1553560-150440] DEBUG -- :   CACHE Organization Pluck (0.0ms)  SELECT "organizations"."id" FROM "organizations" INNER JOIN "organizations_users" ON "organizations"."id" = "organizations_users"."organization_id" WHERE "organizations_users"."user_id" = $1 ORDER BY "organizations"."id" ASC  [["user_id", 922]]
D, [2024-10-23T09:45:35.283733#1553560-150440] DEBUG -- :   CACHE  (0.0ms)  SELECT COUNT(*) AS "size", MAX("object_manager_attributes"."updated_at") AS timestamp FROM "object_manager_attributes" WHERE "object_manager_attributes"."active" = $1 AND "object_manager_attributes"."editable" = $2 AND "object_manager_attributes"."object_lookup_id" = $3  [["active", true], ["editable", true], ["object_lookup_id", 1]]
D, [2024-10-23T09:45:35.285132#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" IN ($1, $2) ORDER BY "organizations"."id" ASC  [["id", 2], ["id", 132]]
D, [2024-10-23T09:45:35.287173#1553560-150440] DEBUG -- :   Ticket Count (1.3ms)  SELECT COUNT(*) FROM (SELECT DISTINCT "tickets".* FROM "tickets" WHERE (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) AND (((("tickets"."state_id" IS NULL OR "tickets"."state_id" NOT IN ('12','4','8','7'))) AND ("tickets"."organization_id" IN (2,132)))) ORDER BY "tickets"."state_id", "tickets"."created_at" DESC) subquery_for_count
D, [2024-10-23T09:45:35.288766#1553560-150440] DEBUG -- :   Role Pluck (0.4ms)  SELECT "roles"."id" FROM "roles" INNER JOIN "overviews_roles" ON "roles"."id" = "overviews_roles"."role_id" WHERE "overviews_roles"."overview_id" = $1  [["overview_id", 57]]
D, [2024-10-23T09:45:35.289950#1553560-150440] DEBUG -- :   User Pluck (0.4ms)  SELECT "users"."id" FROM "users" INNER JOIN "overviews_users" ON "users"."id" = "overviews_users"."user_id" WHERE "overviews_users"."overview_id" = $1  [["overview_id", 57]]
D, [2024-10-23T09:45:35.290782#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.292090#1553560-150440] DEBUG -- :   CACHE Organization Pluck (0.0ms)  SELECT "organizations"."id" FROM "organizations" INNER JOIN "organizations_users" ON "organizations"."id" = "organizations_users"."organization_id" WHERE "organizations_users"."user_id" = $1 ORDER BY "organizations"."id" ASC  [["user_id", 922]]
D, [2024-10-23T09:45:35.293120#1553560-150440] DEBUG -- :   CACHE  (0.0ms)  SELECT COUNT(*) AS "size", MAX("object_manager_attributes"."updated_at") AS timestamp FROM "object_manager_attributes" WHERE "object_manager_attributes"."active" = $1 AND "object_manager_attributes"."editable" = $2 AND "object_manager_attributes"."object_lookup_id" = $3  [["active", true], ["editable", true], ["object_lookup_id", 1]]
D, [2024-10-23T09:45:35.294445#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" IN ($1, $2) ORDER BY "organizations"."id" ASC  [["id", 2], ["id", 132]]
D, [2024-10-23T09:45:35.296427#1553560-150440] DEBUG -- :   Ticket Count (1.3ms)  SELECT COUNT(*) FROM (SELECT DISTINCT "tickets".* FROM "tickets" WHERE (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) AND (((("tickets"."state_id" IS NULL OR "tickets"."state_id" NOT IN ('11'))) AND ("tickets"."organization_id" IN (2,132)))) ORDER BY "tickets"."priority_id", "tickets"."created_at" DESC) subquery_for_count
D, [2024-10-23T09:45:35.298107#1553560-150440] DEBUG -- :   Role Pluck (0.5ms)  SELECT "roles"."id" FROM "roles" INNER JOIN "overviews_roles" ON "roles"."id" = "overviews_roles"."role_id" WHERE "overviews_roles"."overview_id" = $1  [["overview_id", 58]]
D, [2024-10-23T09:45:35.299310#1553560-150440] DEBUG -- :   User Pluck (0.4ms)  SELECT "users"."id" FROM "users" INNER JOIN "overviews_users" ON "users"."id" = "overviews_users"."user_id" WHERE "overviews_users"."overview_id" = $1  [["overview_id", 58]]
D, [2024-10-23T09:45:35.300474#1553560-150440] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2  [["id", 922], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.301608#1553560-150440] DEBUG -- :   CACHE Organization Pluck (0.0ms)  SELECT "organizations"."id" FROM "organizations" INNER JOIN "organizations_users" ON "organizations"."id" = "organizations_users"."organization_id" WHERE "organizations_users"."user_id" = $1 ORDER BY "organizations"."id" ASC  [["user_id", 922]]
D, [2024-10-23T09:45:35.302646#1553560-150440] DEBUG -- :   CACHE  (0.0ms)  SELECT COUNT(*) AS "size", MAX("object_manager_attributes"."updated_at") AS timestamp FROM "object_manager_attributes" WHERE "object_manager_attributes"."active" = $1 AND "object_manager_attributes"."editable" = $2 AND "object_manager_attributes"."object_lookup_id" = $3  [["active", true], ["editable", true], ["object_lookup_id", 1]]
D, [2024-10-23T09:45:35.303942#1553560-150440] DEBUG -- :   CACHE Organization Load (0.0ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" IN ($1, $2) ORDER BY "organizations"."id" ASC  [["id", 2], ["id", 132]]
D, [2024-10-23T09:45:35.304678#1553560-150440] DEBUG -- :   CACHE Ticket Count (0.0ms)  SELECT COUNT(*) FROM (SELECT DISTINCT "tickets".* FROM "tickets" WHERE (tickets.customer_id = 922 OR tickets.organization_id = 2 OR tickets.organization_id = 132) AND ((("tickets"."state_id" IN ('11','2','1','7','3')) AND ("tickets"."organization_id" IN (2,132)))) ORDER BY "tickets"."state_id", "tickets"."created_at" DESC) subquery_for_count
D, [2024-10-23T09:45:35.306155#1553560-150440] DEBUG -- :   User Load (0.7ms)  SELECT "users".* FROM "users" WHERE "users"."id" = $1  [["id", 932]]
D, [2024-10-23T09:45:35.307464#1553560-150440] DEBUG -- :   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = $1 LIMIT $2  [["name", "admin.*"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.310049#1553560-150440] DEBUG -- :   Permission Exists? (1.2ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND ("permissions"."name" = $4 OR permissions.name LIKE 'admin.%') LIMIT $5  [["user_id", 922], ["active", true], ["active", true], ["name", "admin"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.313196#1553560-150440] DEBUG -- :   Organization Load (0.7ms)  SELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 ORDER BY "organizations"."id" ASC  [["id", 132]]
D, [2024-10-23T09:45:35.314371#1553560-150440] DEBUG -- :   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = $1 LIMIT $2  [["name", "admin.organization"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.316460#1553560-150440] DEBUG -- :   Permission Exists? (1.1ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND "permissions"."name" IN ($4, $5, $6, $7) LIMIT $8  [["user_id", 922], ["active", true], ["active", true], ["name", "admin"], ["name", "admin.organization"], ["name", "ticket"], ["name", "ticket.agent"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.317964#1553560-150440] DEBUG -- :   Ticket::State Load (0.5ms)  SELECT "ticket_states".* FROM "ticket_states" WHERE "ticket_states"."id" = $1  [["id", 1]]
D, [2024-10-23T09:45:35.319638#1553560-150440] DEBUG -- :   Group Load (0.6ms)  SELECT "groups".* FROM "groups" WHERE "groups"."id" = $1  [["id", 4]]
D, [2024-10-23T09:45:35.320795#1553560-150440] DEBUG -- :   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = $1 LIMIT $2  [["name", "admin.group"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.322801#1553560-150440] DEBUG -- :   Permission Exists? (1.1ms)  SELECT 1 AS one FROM "permissions" INNER JOIN "permissions_roles" ON "permissions"."id" = "permissions_roles"."permission_id" INNER JOIN "roles" ON "permissions_roles"."role_id" = "roles"."id" INNER JOIN "roles_users" ON "roles"."id" = "roles_users"."role_id" WHERE "roles_users"."user_id" = $1 AND "roles"."active" = $2 AND "permissions"."active" = $3 AND "permissions"."name" IN ($4, $5) LIMIT $6  [["user_id", 922], ["active", true], ["active", true], ["name", "admin"], ["name", "admin.group"], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.324727#1553560-150440] DEBUG -- :   Ticket Exists? (0.8ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.326864#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.328434#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.330051#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.331630#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.333527#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.335088#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.336683#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.338256#1553560-150440] DEBUG -- :   CACHE Ticket Exists? (0.0ms)  SELECT 1 AS one FROM "tickets" WHERE "tickets"."customer_id" = $1 AND "tickets"."group_id" = $2 LIMIT $3  [["customer_id", 922], ["group_id", 4], ["LIMIT", 1]]
D, [2024-10-23T09:45:35.339446#1553560-150440] DEBUG -- :   Ticket::StateType Load (0.6ms)  SELECT "ticket_state_types".* FROM "ticket_state_types" WHERE "ticket_state_types"."id" = $1  [["id", 1]]
D, [2024-10-23T09:45:35.341828#1553560-150440] DEBUG -- :   Setting Load (0.5ms)  SELECT "settings".* FROM "settings" WHERE "settings"."area" = $1 ORDER BY "settings"."name" ASC  [["area", "Transaction::Backend::Sync"]]
I, [2024-10-23T09:45:35.342183#1553560-150440]  INFO -- : Completed 200 OK in 195ms (Views: 0.8ms | ActiveRecord: 43.4ms | Allocations: 51442)

Best Regards,

fliebe92 · October 24, 2024, 8:01am

Hi @wagner.loch. Thanks for the logs. I need to think about it…

wagner.loch · October 30, 2024, 5:44pm

Hi @fliebe92, thank you for helping us.

Take all the time you need to review the logs, but I would appreciate any tips you might have for troubleshooting this issue.

Best Regards.

fliebe92 · October 30, 2024, 6:50pm

Hi @wagner.loch. We tested different scenarios, but with no luck so far on how to reproduce the issue you are faced with. Sorry.

dominikklein · October 30, 2024, 9:42pm

Could be that without debugging it “live” it will be difficult.