D, [2023-10-02T07:06:50.701141 #19776 DEBUG -- : [d4b1aa8f-bbce-4014-88b6-4c69e49455ed] ][1m][35m (0.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:50.703345 #19776 DEBUG -- : [d4b1aa8f-bbce-4014-88b6-4c69e49455ed] ][1m][35mSQL (0.8ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414233], ["name", "Viewed: users#show"], ["properties", "{}"], ["time", 2023-10-02 07:06:50 UTC]]]

D, [2023-10-02T07:06:50.709284 #19776 DEBUG -- : [d4b1aa8f-bbce-4014-88b6-4c69e49455ed] ][1m][35m (5.4ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:06:50.709761 #19776] INFO -- : [d4b1aa8f-bbce-4014-88b6-4c69e49455ed] {:_method=>"GET", :_path=>"/users/mjram0s", :_format=>:html, :_controller=>"UsersController", :_action=>"show", :_status=>200, :_duration=>3172.41, :_view=>2818.58, :_db=>327.34, :_time=>2023-10-02 07:06:47 +0000, :short_message=>"[200] GET /users/mjram0s (UsersController#show)"}

D, [2023-10-02T07:06:51.073226 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][35m (0.1ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:51.076353 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][35mSQL (1.5ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "13c65e80-252f-45cc-8c8a-fb6024e0727c"], ["visitor_token", "733cc3a2-9420-48ff-8ce9-e1619ddc808c"], ["ip", "64.252.85.23"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/users?package_id=Unrolled&page=12"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:06:51 UTC]]]

D, [2023-10-02T07:06:51.077666 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][35m (0.8ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:06:51.078946 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] [ActiveJob] ][1m][35m (0.1ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:51.080287 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] [ActiveJob] ][1m][35mSQL (0.4ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: 69a6869a-e9b9-4aca-8e51-182be950afed\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414234\n locale: en\n"], ["run_at", 2023-10-02 07:06:51 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:06:51 UTC], ["updated_at", 2023-10-02 07:06:51 UTC]]]

D, [2023-10-02T07:06:51.081969 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] [ActiveJob] ][1m][35m (1.3ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:06:51.082310 #19776] INFO -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: 69a6869a-e9b9-4aca-8e51-182be950afed) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f5136746ee8 @uri=#<URI::GID gid://julia-observer/Visit/16414234>>

D, [2023-10-02T07:06:51.085032 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][36mOrganization Load (1.1ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:06:51.189983 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][36mPackage Exists (103.3ms)][0m ][1m][34mSELECT 1 AS one FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."name" = $3 LIMIT $4][0m [["item_type", "Package"], ["marker", 5699], ["name", "Unrolled"], ["LIMIT", 1]]]

D, [2023-10-02T07:06:51.192219 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][36mPackage Exists (0.7ms)][0m ][1m][34mSELECT 1 AS one FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."id" = $3 LIMIT $4][0m [["item_type", "Package"], ["marker", 5699], ["id", 0], ["LIMIT", 1]]]

D, [2023-10-02T07:06:51.194023 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][36mCACHE (0.0ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:06:51.258567 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][36mPackage Load (63.5ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND (name ILIKE '%Unrolled%')][0m [["item_type", "Package"], ["marker", 5699]]]

D, [2023-10-02T07:06:51.271481 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][36mUser Load (7.7ms)][0m ][1m][34mSELECT "users".* FROM "users" INNER JOIN "batches" ON "batches"."item_id" = "users"."id" AND "batches"."item_type" = $1 INNER JOIN "contributions" ON "contributions"."user_id" = "users"."id" INNER JOIN "packages" ON "packages"."id" = "contributions"."package_id" WHERE "batches"."marker" = $2 AND "packages"."is_registered" = $3 GROUP BY users.id HAVING (sum(contributions.score) >= 10 or count(contributions.score) > 1) ORDER BY sum(contributions.score) desc LIMIT $4 OFFSET $5][0m [["item_type", "User"], ["marker", 5699], ["is_registered", true], ["LIMIT", 100], ["OFFSET", 1100]]]

D, [2023-10-02T07:06:51.285285 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][35m (12.1ms)][0m ][1m][34mSELECT COUNT(*) AS count_all, users.id AS users_id FROM "users" INNER JOIN "batches" ON "batches"."item_id" = "users"."id" AND "batches"."item_type" = $1 INNER JOIN "contributions" ON "contributions"."user_id" = "users"."id" INNER JOIN "packages" ON "packages"."id" = "contributions"."package_id" WHERE "batches"."marker" = $2 AND "packages"."is_registered" = $3 GROUP BY users.id HAVING (sum(contributions.score) >= 10 or count(contributions.score) > 1)][0m [["item_type", "User"], ["marker", 5699], ["is_registered", true]]]

D, [2023-10-02T07:06:51.542704 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][36mRelease Load (237.5ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:06:54.653093 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][35m (6.4ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:54.655281 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][35mSQL (0.7ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414234], ["name", "Viewed: users#index"], ["properties", "{}"], ["time", 2023-10-02 07:06:54 UTC]]]

D, [2023-10-02T07:06:54.656537 #19776 DEBUG -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] ][1m][35m (0.9ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:06:54.656899 #19776] INFO -- : [cd7e0d1c-49c3-4fb4-90e9-2cf299f49f04] {:_method=>"GET", :_path=>"/users", :_format=>:html, :_controller=>"UsersController", :_action=>"index", :_status=>200, :_duration=>3592.43, :_view=>3128.23, :_db=>438.13, :_time=>2023-10-02 07:06:51 +0000, :short_message=>"[200] GET /users (UsersController#index)"}

D, [2023-10-02T07:06:56.469244 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][35m (0.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:56.472080 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][35mSQL (1.4ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "3501aeea-9a39-4f2c-b8aa-520606048605"], ["visitor_token", "56110c02-18d8-4166-b1e0-05bb0d185b84"], ["ip", "64.252.85.231"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/users?package_id=Unrolled&page=13"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:06:56 UTC]]]

D, [2023-10-02T07:06:56.473260 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][35m (0.7ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:06:56.474528 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] [ActiveJob] ][1m][35m (0.1ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:56.475862 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] [ActiveJob] ][1m][35mSQL (0.4ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: ab3e59fe-285a-498f-aa25-4e0be3769094\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414235\n locale: en\n"], ["run_at", 2023-10-02 07:06:56 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:06:56 UTC], ["updated_at", 2023-10-02 07:06:56 UTC]]]

D, [2023-10-02T07:06:56.476770 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] [ActiveJob] ][1m][35m (0.6ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:06:56.477073 #19776] INFO -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: ab3e59fe-285a-498f-aa25-4e0be3769094) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f514825ce98 @uri=#<URI::GID gid://julia-observer/Visit/16414235>>

D, [2023-10-02T07:06:56.479325 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][36mOrganization Load (0.8ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:06:56.497028 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][36mPackage Exists (16.0ms)][0m ][1m][34mSELECT 1 AS one FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."name" = $3 LIMIT $4][0m [["item_type", "Package"], ["marker", 5699], ["name", "Unrolled"], ["LIMIT", 1]]]

D, [2023-10-02T07:06:56.498986 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][36mPackage Exists (0.6ms)][0m ][1m][34mSELECT 1 AS one FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."id" = $3 LIMIT $4][0m [["item_type", "Package"], ["marker", 5699], ["id", 0], ["LIMIT", 1]]]

D, [2023-10-02T07:06:56.500238 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][36mCACHE (0.0ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:06:56.561344 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][36mPackage Load (59.9ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND (name ILIKE '%Unrolled%')][0m [["item_type", "Package"], ["marker", 5699]]]

D, [2023-10-02T07:06:56.581038 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][36mUser Load (14.4ms)][0m ][1m][34mSELECT "users".* FROM "users" INNER JOIN "batches" ON "batches"."item_id" = "users"."id" AND "batches"."item_type" = $1 INNER JOIN "contributions" ON "contributions"."user_id" = "users"."id" INNER JOIN "packages" ON "packages"."id" = "contributions"."package_id" WHERE "batches"."marker" = $2 AND "packages"."is_registered" = $3 GROUP BY users.id HAVING (sum(contributions.score) >= 10 or count(contributions.score) > 1) ORDER BY sum(contributions.score) desc LIMIT $4 OFFSET $5][0m [["item_type", "User"], ["marker", 5699], ["is_registered", true], ["LIMIT", 100], ["OFFSET", 1200]]]

D, [2023-10-02T07:06:56.596026 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][35m (13.2ms)][0m ][1m][34mSELECT COUNT(*) AS count_all, users.id AS users_id FROM "users" INNER JOIN "batches" ON "batches"."item_id" = "users"."id" AND "batches"."item_type" = $1 INNER JOIN "contributions" ON "contributions"."user_id" = "users"."id" INNER JOIN "packages" ON "packages"."id" = "contributions"."package_id" WHERE "batches"."marker" = $2 AND "packages"."is_registered" = $3 GROUP BY users.id HAVING (sum(contributions.score) >= 10 or count(contributions.score) > 1)][0m [["item_type", "User"], ["marker", 5699], ["is_registered", true]]]

D, [2023-10-02T07:06:56.900798 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][36mRelease Load (290.7ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:06:58.701503 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (300.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:58.705167 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35mSQL (2.2ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "0a6ef894-b8e6-4589-8e6e-e2ed50023248"], ["visitor_token", "d2840a79-c490-46ab-ba14-8aed5a1e7ed4"], ["ip", "64.252.104.213"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/packages/AbstractLattices"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:06:58 UTC]]]

D, [2023-10-02T07:06:58.817143 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (111.3ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:06:58.919399 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] [ActiveJob] ][1m][35m (100.4ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:06:59.021923 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] [ActiveJob] ][1m][35mSQL (100.7ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: 69e06196-9bed-4b4f-add1-79e41f753280\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414236\n locale: en\n"], ["run_at", 2023-10-02 07:06:58 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:06:58 UTC], ["updated_at", 2023-10-02 07:06:58 UTC]]]

D, [2023-10-02T07:06:59.123714 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] [ActiveJob] ][1m][35m (101.2ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:06:59.124164 #19776] INFO -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: 69e06196-9bed-4b4f-add1-79e41f753280) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f513fdbee70 @uri=#<URI::GID gid://julia-observer/Visit/16414236>>

D, [2023-10-02T07:06:59.227025 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mOrganization Load (101.1ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:00.294171 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mPackage Load (1065.2ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."name" = $3 LIMIT $4][0m [["item_type", "Package"], ["marker", 5699], ["name", "AbstractLattices"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:00.334202 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mContribution Load (34.8ms)][0m ][1m][34mSELECT "contributions".* FROM "contributions" WHERE "contributions"."package_id" = $1 ORDER BY "contributions"."score" DESC LIMIT $2][0m [["package_id", 43706544], ["LIMIT", 20]]]

D, [2023-10-02T07:07:00.341203 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mUser Load (4.7ms)][0m ][1m][34mSELECT "users".* FROM "users" WHERE "users"."id" IN (12720933, 12720601)][0m]

D, [2023-10-02T07:07:00.355100 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][35m (21.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:00.365301 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][35mSQL (8.0ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414235], ["name", "Viewed: users#index"], ["properties", "{}"], ["time", 2023-10-02 07:07:00 UTC]]]

D, [2023-10-02T07:07:00.367452 #19776 DEBUG -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] ][1m][35m (1.3ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:00.368104 #19776] INFO -- : [76cfa58f-17e9-4e6d-8257-9557ccf471af] {:_method=>"GET", :_path=>"/users", :_format=>:html, :_controller=>"UsersController", :_action=>"index", :_status=>200, :_duration=>3909.63, :_view=>3451.07, :_db=>429.28, :_time=>2023-10-02 07:06:56 +0000, :short_message=>"[200] GET /users (UsersController#index)"}

D, [2023-10-02T07:07:00.370306 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mRepository Load (15.3ms)][0m ][1m][34mSELECT "repositories".* FROM "repositories" WHERE "repositories"."package_id" = $1 LIMIT $2][0m [["package_id", 43706544], ["LIMIT", 1]]]

D, [2023-10-02T07:07:00.381195 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mCounter Load (5.2ms)][0m ][1m][34mSELECT "counters".* FROM "counters" WHERE "counters"."package_id" = $1 LIMIT $2][0m [["package_id", 43706544], ["LIMIT", 1]]]

D, [2023-10-02T07:07:00.395459 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mDater Load (0.6ms)][0m ][1m][34mSELECT "daters".* FROM "daters" WHERE "daters"."package_id" = $1 LIMIT $2][0m [["package_id", 43706544], ["LIMIT", 1]]]

D, [2023-10-02T07:07:00.397597 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mContribution Load (0.3ms)][0m ][1m][34mSELECT "contributions".* FROM "contributions" WHERE "contributions"."package_id" = $1][0m [["package_id", 43706544]]]

D, [2023-10-02T07:07:00.423428 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35mSQL (4.1ms)][0m ][1m][34mSELECT "dependencies"."id" AS t0_r0, "dependencies"."dependent_id" AS t0_r1, "dependencies"."depended_id" AS t0_r2, "dependencies"."created_at" AS t0_r3, "dependencies"."updated_at" AS t0_r4, "dependencies"."is_shallow" AS t0_r5, "packages"."id" AS t1_r0, "packages"."name" AS t1_r1, "packages"."created_at" AS t1_r2, "packages"."updated_at" AS t1_r3, "packages"."description" AS t1_r4, "packages"."homepage" AS t1_r5, "packages"."owner_type" AS t1_r6, "packages"."owner_id" AS t1_r7, "packages"."is_registered" AS t1_r8, "packages"."readme" AS t1_r9, "packages"."readme_type" AS t1_r10, "counters"."id" AS t2_r0, "counters"."fork" AS t2_r1, "counters"."stargazer" AS t2_r2, "counters"."open_issue" AS t2_r3, "counters"."package_id" AS t2_r4, "counters"."created_at" AS t2_r5, "counters"."updated_at" AS t2_r6, "counters"."contributor" AS t2_r7 FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."depended_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."dependent_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AbstractLattices')) AND "packages"."is_registered" = $2 ORDER BY "dependencies"."is_shallow" DESC, counters.stargazer desc][0m [["dependent_id", 43706544], ["is_registered", true]]]

D, [2023-10-02T07:07:00.429721 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35mSQL (2.8ms)][0m ][1m][34mSELECT "dependencies"."id" AS t0_r0, "dependencies"."dependent_id" AS t0_r1, "dependencies"."depended_id" AS t0_r2, "dependencies"."created_at" AS t0_r3, "dependencies"."updated_at" AS t0_r4, "dependencies"."is_shallow" AS t0_r5, "packages"."id" AS t1_r0, "packages"."name" AS t1_r1, "packages"."created_at" AS t1_r2, "packages"."updated_at" AS t1_r3, "packages"."description" AS t1_r4, "packages"."homepage" AS t1_r5, "packages"."owner_type" AS t1_r6, "packages"."owner_id" AS t1_r7, "packages"."is_registered" AS t1_r8, "packages"."readme" AS t1_r9, "packages"."readme_type" AS t1_r10, "counters"."id" AS t2_r0, "counters"."fork" AS t2_r1, "counters"."stargazer" AS t2_r2, "counters"."open_issue" AS t2_r3, "counters"."package_id" AS t2_r4, "counters"."created_at" AS t2_r5, "counters"."updated_at" AS t2_r6, "counters"."contributor" AS t2_r7 FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."dependent_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."depended_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AbstractLattices', 'Cuddle')) AND "packages"."is_registered" = $2 ORDER BY "dependencies"."is_shallow" DESC, counters.stargazer desc][0m [["depended_id", 43706544], ["is_registered", true]]]

D, [2023-10-02T07:07:00.434197 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (1.6ms)][0m ][1m][34mSELECT DISTINCT COUNT(DISTINCT "dependencies"."id") FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."depended_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."dependent_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AbstractLattices')) AND "packages"."is_registered" = $2][0m [["dependent_id", 43706544], ["is_registered", true]]]

D, [2023-10-02T07:07:00.438139 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (2.1ms)][0m ][1m][34mSELECT DISTINCT COUNT(DISTINCT "dependencies"."id") FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."dependent_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."depended_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AbstractLattices', 'Cuddle')) AND "packages"."is_registered" = $2][0m [["depended_id", 43706544], ["is_registered", true]]]

D, [2023-10-02T07:07:00.442204 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (1.9ms)][0m ][1m][34mSELECT DISTINCT COUNT(DISTINCT "dependencies"."id") FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."dependent_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."depended_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AbstractLattices', 'Cuddle')) AND "packages"."is_registered" = $2 AND "dependencies"."is_shallow" = $3][0m [["depended_id", 43706544], ["is_registered", true], ["is_shallow", true]]]

D, [2023-10-02T07:07:00.443696 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mCACHE (0.0ms)][0m ][1m][34mSELECT DISTINCT COUNT(DISTINCT "dependencies"."id") FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."dependent_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."depended_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AbstractLattices', 'Cuddle')) AND "packages"."is_registered" = $2][0m [["depended_id", 43706544], ["is_registered", true]]]

D, [2023-10-02T07:07:00.453519 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mUser Load (0.3ms)][0m ][1m][34mSELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT $2][0m [["id", 12720933], ["LIMIT", 1]]]

D, [2023-10-02T07:07:00.461128 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mActivity Load (3.4ms)][0m ][1m][34mSELECT "activities".* FROM "activities" WHERE "activities"."package_id" = $1 LIMIT $2][0m [["package_id", 43706544], ["LIMIT", 1]]]

D, [2023-10-02T07:07:00.469373 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (3.4ms)][0m ][1m][34mSELECT COUNT(*) FROM "versions" WHERE "versions"."package_id" = $1][0m [["package_id", 43706544]]]

D, [2023-10-02T07:07:00.473793 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mVersion Load (0.6ms)][0m ][1m][34mSELECT "versions".* FROM "versions" WHERE "versions"."package_id" = $1 ORDER BY "versions"."major" ASC, "versions"."minor" ASC, "versions"."patch" ASC][0m [["package_id", 43706544]]]

D, [2023-10-02T07:07:00.862062 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][36mRelease Load (366.0ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:07:03.055005 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35m (604.5ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:03.058755 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35mSQL (2.0ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "eefd94a1-4d60-439a-870b-5adf500a9137"], ["visitor_token", "03dd00eb-d3fb-4c6f-8bc1-1c60a9a342d9"], ["ip", "64.252.67.9"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/categories/Utilities"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:07:02 UTC]]]

D, [2023-10-02T07:07:03.060453 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35m (1.0ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:07:03.269008 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] ][1m][35m (206.7ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:03.271406 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] ][1m][35mSQL (0.6ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: 530d2219-a41f-4156-aff0-6d4cb9eff1bd\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414237\n locale: en\n"], ["run_at", 2023-10-02 07:07:03 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:07:03 UTC], ["updated_at", 2023-10-02 07:07:03 UTC]]]

D, [2023-10-02T07:07:03.272950 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] ][1m][35m (1.0ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:03.273340 #19776] INFO -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: 530d2219-a41f-4156-aff0-6d4cb9eff1bd) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f512f75e680 @uri=#<URI::GID gid://julia-observer/Visit/16414237>>

D, [2023-10-02T07:07:03.385341 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][36mCategory Load (110.0ms)][0m ][1m][34mSELECT "categories".* FROM "categories" INNER JOIN "batches" ON "batches"."item_id" = "categories"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "categories"."name" = $3 LIMIT $4][0m [["item_type", "Category"], ["marker", 5699], ["name", "Utilities"], ["LIMIT", 1]]]

I, [2023-10-02T07:07:03.392207 #19776] INFO -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] [PackageSorterJob] [8800b4fe-b404-4fd1-b742-cd1fdc30a53a] Performing PackageSorterJob from DelayedJob(default) with arguments: {"controller"=>"categories", "action"=>"show", "category_id"=>"Utilities"}, #<ActionDispatch::Cookies::CookieJar:0x00007f5127ef90a0 @set_cookies={"ahoy_visitor"=>{:value=>"03dd00eb-d3fb-4c6f-8bc1-1c60a9a342d9", :expires=>Thu, 02 Oct 2025 07:07:02 UTC +00:00, :domain=>".juliaobserver.com", :path=>"/"}, "ahoy_visit"=>{:value=>"eefd94a1-4d60-439a-870b-5adf500a9137", :expires=>Mon, 02 Oct 2023 11:07:02 UTC +00:00, :domain=>".juliaobserver.com", :path=>"/"}}, @delete_cookies={}, @request=#<ActionDispatch::Request:0x00007f514b5c08e8 @env={"rack.version"=>[1, 3], "rack.errors"=>#<IO:<STDERR>>, "rack.multithread"=>true, "rack.multiprocess"=>false, "rack.run_once"=>false, "SCRIPT_NAME"=>"", "QUERY_STRING"=>"", "SERVER_PROTOCOL"=>"HTTP/1.1", "SERVER_SOFTWARE"=>"puma 3.12.1 Llamas in Pajamas", "GATEWAY_INTERFACE"=>"CGI/1.2", "REQUEST_METHOD"=>"GET", "REQUEST_PATH"=>"/categories/Utilities", "REQUEST_URI"=>"/categories/Utilities", "HTTP_VERSION"=>"HTTP/1.0", "HTTP_HOST"=>"cdn.juliaobserver.com", "HTTP_X_REAL_IP"=>"64.252.67.9", "HTTP_X_FORWARDED_FOR"=>"34.204.172.188, 64.252.67.9", "HTTP_X_FORWARDED_PROTO"=>"http", "HTTP_CONNECTION"=>"close", "HTTP_USER_AGENT"=>"Amazon CloudFront", "HTTP_X_AMZ_CF_ID"=>"OImdaBPveCJxyZ8EQE2aakL3vK9irPIcDuExM1e-fbQPxOTB623RtQ==", "HTTP_VIA"=>"1.1 7a887c7cb9fe4a7abca02d85e8b196e8.cloudfront.net (CloudFront)", "HTTP_ACCEPT_ENCODING"=>"gzip", "HTTP_CLOUDFRONT_VIEWER_COUNTRY"=>"US", "SERVER_NAME"=>"cdn.juliaobserver.com", "SERVER_PORT"=>"80", "PATH_INFO"=>"/categories/Utilities", "REMOTE_ADDR"=>"127.0.0.1", "puma.socket"=>#<TCPSocket:fd 13, AF_INET, 127.0.0.1, 3000>, "rack.hijack?"=>true, "rack.hijack"=>#<Puma::Client:0x3fa893a5beac @ready=true>, "rack.input"=>#<Puma::NullIO:0x00005641027cd960>, "rack.url_scheme"=>"http", "rack.after_reply"=>[], "puma.config"=>#<Puma::Configuration:0x000056410293b8d8 @options=#<Puma::UserFileDefaultOptions:0x000056410293b6f8 @user_options={:environment=>"production"}, @file_options={:min_threads=>5, :max_threads=>5, :binds=>["tcp://0.0.0.0:3000"], :environment=>"production"}, @default_options={:min_threads=>0, :max_threads=>16, :log_requests=>false, :debug=>false, :binds=>["tcp://0.0.0.0:9292"], :workers=>0, :daemon=>false, :mode=>:http, :worker_timeout=>60, :worker_boot_timeout=>60, :worker_shutdown_timeout=>30, :remote_address=>:socket, :tag=>"julia_observer", :environment=>"production", :rackup=>"config.ru", :logger=>#<IO:<STDOUT>>, :persistent_timeout=>20, :first_data_timeout=>30}>, @plugins=#<Puma::PluginLoader:0x000056410293b6a8 @instances=[#<#<Class:0x000056410297b898>:0x000056410297b7d0 @loader=Puma::Plugin>]>, @user_dsl=#<Puma::DSL:0x000056410293b658 @config=#<Puma::Configuration:0x000056410293b8d8 ...>, @options={:environment=>"production"}, @plugins=[]>, @file_dsl=#<Puma::DSL:0x000056410293b608 @config=#<Puma::Configuration:0x000056410293b8d8 ...>, @options={:min_threads=>5, :max_threads=>5, :binds=>["tcp://0.0.0.0:3000"], :environment=>"production"}, @plugins=[], @path="config/puma.rb">, @default_dsl=#<Puma::DSL:0x000056410293b5b8 @config=#<Puma::Configuration:0x000056410293b8d8 ...>, @options={:min_threads=>0, :max_threads=>16, :log_requests=>false, :debug=>false, :binds=>["tcp://0.0.0.0:9292"], :workers=>0, :daemon=>false, :mode=>:http, :worker_timeout=>60, :worker_boot_timeout=>60, :worker_shutdown_timeout=>30, :remote_address=>:socket, :tag=>"julia_observer", :environment=>"production", :rackup=>"config.ru", :logger=>#<IO:<STDOUT>>, :persistent_timeout=>20, :first_data_timeout=>30}, @plugins=[]>>, "action_dispatch.parameter_filter"=>[:password], "action_dispatch.redirect_filter"=>[], "action_dispatch.secret_token"=>nil, "action_dispatch.secret_key_base"=>"4fba9bb4f507809b538fbfaec3d81791ceb10d67c2c41396d13713d6c9e2fbbe936e079ab7efaad736ac19f965e1e7b8811c20c0b159ecab2c3cf24e88dccdd5", "action_dispatch.show_exceptions"=>true, "action_dispatch.show_detailed_exceptions"=>true, "action_dispatch.logger"=>#<ActiveSupport::Logger:0x000056410516d108 @level=0, @progname=nil, @default_formatter=#<Logger::Formatter:0x000056410516d090 @datetime_format=nil>, @formatter=#<Logger::Formatter:0x000056410516db58 @datetime_format=nil, @thread_key="activesupport_tagged_logging_tags:47418629123500">, @logdev=#<Logger::LogDevice:0x000056410516d040 @shift_period_suffix=nil, @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<File:/home/rails/julia_observer/log/production.log>, @mon_mutex=#<Thread::Mutex:0x000056410516cff0>, @mon_mutex_owner_object_id=47418629122080, @mon_owner=nil, @mon_count=0>, @local_levels=#<Concurrent::Map:0x000056410516cf28 entries=0 default_proc=nil>, @thread_hash_level_key=:"ThreadSafeLogger#47418629122180@level">, "action_dispatch.backtrace_cleaner"=>#<Rails::BacktraceCleaner:0x0000564103eaebc0 @filters=[#<Proc:0x0000564103eae918@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:14>, #<Proc:0x0000564103eae8f0@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:15>, #<Proc:0x0000564103eae850@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:16>, #<Proc:0x0000564103ed6e40@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:29>], @silencers=[#<Proc:0x0000564103ed6dc8@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:19>], @root="/home/rails/julia_observer/">, "action_dispatch.key_generator"=>#<ActiveSupport::CachingKeyGenerator:0x0000564104ed87d0 @key_generator=#<ActiveSupport::KeyGenerator:0x0000564104ed87f8 @secret="4fba9bb4f507809b538fbfaec3d81791ceb10d67c2c41396d13713d6c9e2fbbe936e079ab7efaad736ac19f965e1e7b8811c20c0b159ecab2c3cf24e88dccdd5", @iterations=1000>, @cache_keys=#<Concurrent::Map:0x0000564104ed87a8 entries=3 default_proc=nil>>, "action_dispatch.http_auth_salt"=>"http authentication", "action_dispatch.signed_cookie_salt"=>"signed cookie", "action_dispatch.encrypted_cookie_salt"=>"encrypted cookie", "action_dispatch.encrypted_signed_cookie_salt"=>"signed encrypted cookie", "action_dispatch.cookies_serializer"=>:json, "action_dispatch.cookies_digest"=>nil, "action_dispatch.routes"=>#<ActionDispatch::Routing::RouteSet:0x0000564105077708>, "ROUTES_47418628619140_SCRIPT_NAME"=>"", "ORIGINAL_FULLPATH"=>"/categories/Utilities", "ORIGINAL_SCRIPT_NAME"=>"", "rack.cors"=>#<Rack::Cors::Result:0x00007f51274b7538 @preflight=false, @hit=false, @miss_reason="no-origin">, "action_dispatch.request_id"=>"2953d6eb-f9ee-4b66-858a-e06b58227833", "action_dispatch.remote_ip"=>#<ActionDispatch::RemoteIp::GetIp:0x00007f51274b66b0 @req=#<ActionDispatch::Request:0x00007f51274b66d8 @env={...}, @filtered_parameters=nil, @filtered_env=nil, @filtered_path=nil, @protocol=nil, @port=nil, @method=nil, @request_method=nil, @remote_ip=nil, @original_fullpath=nil, @fullpath=nil, @ip=nil>, @check_ip=true, @proxies=[#<IPAddr: IPv4:127.0.0.1/255.255.255.255>, #<IPAddr: IPv6:0000:0000:0000:0000:0000:0000:0000:0001/ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff>, #<IPAddr: IPv6:fc00:0000:0000:0000:0000:0000:0000:0000/fe00:0000:0000:0000:0000:0000:0000:0000>, #<IPAddr: IPv4:10.0.0.0/255.0.0.0>, #<IPAddr: IPv4:172.16.0.0/255.240.0.0>, #<IPAddr: IPv4:192.168.0.0/255.255.0.0>], @ip="64.252.67.9">, "rack.session"=>#<ActionDispatch::Request::Session:0x7f51274b65c0 not yet loaded>, "rack.session.options"=>#<ActionDispatch::Request::Session::Options:0x00007f51274b6570 @by=#<ActionDispatch::Session::CookieStore:0x000056410615b5d8 @app=#<Rack::Head:0x000056410615b600 @app=#<Rack::ConditionalGet:0x000056410615b628 @app=#<Rack::ETag:0x000056410615b650 @app=#<Rack::Attack:0x000056410615b678 @app=#<Ahoy::Throttle:0x000056410615b6a0 @app=#<ActionDispatch::Routing::RouteSet:0x0000564105077708>>>, @cache_control="max-age=0, private, must-revalidate", @no_cache_control="no-cache">>>, @default_options={:path=>"/", :domain=>nil, :expire_after=>nil, :secure=>false, :httponly=>true, :defer=>false, :renew=>false}, @key="_julia_observer_session", @cookie_only=true>, @delegate={:path=>"/", :domain=>nil, :expire_after=>nil, :secure=>false, :httponly=>true, :defer=>false, :renew=>false}>, "rack.attack.throttle_data"=>{"req/ip"=>{:count=>1, :period=>300, :limit=>500, :epoch_time=>1696230422}}, "action_dispatch.request.path_parameters"=>{:controller=>"categories", :action=>"show", :id=>"Utilities"}, "action_controller.instance"=>#<CategoriesController:0x00007f5127efb710 @_action_has_layout=true, @_routes=nil, @_request=#<ActionDispatch::Request:0x00007f514b5c08e8 ...>, @_response=#<ActionDispatch::Response:0x00007f5127efb918 @mon_mutex=#<Thread::Mutex:0x00007f5127efb8c8>, @mon_mutex_owner_object_id=69993269550220, @mon_owner=nil, @mon_count=0, @header={"X-Frame-Options"=>"SAMEORIGIN", "X-XSS-Protection"=>"1; mode=block", "X-Content-Type-Options"=>"nosniff"}, @stream=#<ActionDispatch::Response::Buffer:0x00007f5127efb878 @response=#<ActionDispatch::Response:0x00007f5127efb918 ...>, @buf=[], @closed=false, @str_body=nil>, @status=200, @cv=#<MonitorMixin::ConditionVariable:0x00007f5127efb850 @monitor=#<ActionDispatch::Response:0x00007f5127efb918 ...>, @cond=#<Thread::ConditionVariable:0x00007f5127efb828>>, @committed=false, @sending=false, @sent=false, @cache_control={}, @request=#<ActionDispatch::Request:0x00007f514b5c08e8 ...>>, @_lookup_context=#<ActionView::LookupContext:0x00007f5127efb620 @details_key=nil, @cache=true, @prefixes=["categories", "application"], @rendered_format=nil, @details={:locale=>[:en], :formats=>[:html], :variants=>[], :handlers=>[:raw, :erb, :html, :builder, :ruby, :coffee, :jbuilder]}, @view_paths=#<ActionView::PathSet:0x00007f5127efb530 @paths=[#<ActionView::OptimizedFileSystemResolver:0x0000564105156cc8 @pattern=":prefix/:action{.:locale,}{.:formats,}{+:variants,}{.:handlers,}", @cache=#<ActionView::Resolver::Cache:0x564105156ca0 keys=334 queries=0>, @path="/home/rails/julia_observer/app/views">]>>, @_action_name="show", @_response_body=nil, @ahoy=#<Ahoy::Tracker:0x00007f5127efa388 @store=#<Ahoy::Store:0x00007f5127efa310 @options={:controller=>#<CategoriesController:0x00007f5127efb710 ...>, :ahoy=>#<Ahoy::Tracker:0x00007f5127efa388 ...>}, @controller=#<CategoriesController:0x00007f5127efb710 ...>, @request=#<ActionDispatch::Request:0x00007f514b5c08e8 ...>, @bot=false, @ahoy=#<Ahoy::Tracker:0x00007f5127efa388 ...>, @user=nil, @visit=#<Visit id: 16414237, visit_token: "eefd94a1-4d60-439a-870b-5adf500a9137", visitor_token: "03dd00eb-d3fb-4c6f-8bc1-1c60a9a342d9", ip: "64.252.67.9", user_agent: "Amazon CloudFront", referrer: nil, landing_page: "http://cdn.juliaobserver.com/categories/Utilities", user_id: nil, referring_domain: nil, search_keyword: nil, browser: "Other", os: "Other", device_type: "Desktop", screen_height: nil, screen_width: nil, country: nil, region: nil, city: nil, postal_code: nil, latitude: nil, longitude: nil, utm_source: nil, utm_medium: nil, utm_term: nil, utm_content: nil, utm_campaign: nil, started_at: "2023-10-02 07:07:02">>, @controller=#<CategoriesController:0x00007f5127efb710 ...>, @request=#<ActionDispatch::Request:0x00007f514b5c08e8 ...>, @options={:controller=>#<CategoriesController:0x00007f5127efb710 ...>}, @visitor_header=nil, @visitor_cookie=nil, @existing_visitor_token=nil, @visitor_token_helper="03dd00eb-d3fb-4c6f-8bc1-1c60a9a342d9", @visitor_id="03dd00eb-d3fb-4c6f-8bc1-1c60a9a342d9", @visit_header=nil, @visit_cookie=nil, @existing_visit_token=nil, @visit_token_helper="eefd94a1-4d60-439a-870b-5adf500a9137", @visit_id="eefd94a1-4d60-439a-870b-5adf500a9137", @visit_token="eefd94a1-4d60-439a-870b-5adf500a9137", @visitor_token="03dd00eb-d3fb-4c6f-8bc1-1c60a9a342d9", @visit_properties=#<Ahoy::VisitProperties:0x00007f51259918a8 @request=#<ActionDispatch::Request:0x00007f514b5c08e8 ...>, @options={:api=>nil}, @request_deckhand=#<Ahoy::Deckhands::RequestDeckhand:0x00007f5125991790 @request=#<ActionDispatch::Request:0x00007f514b5c08e8 ...>, @options={:api=>nil}, @params={"controller"=>"categories", "action"=>"show", "id"=>"Utilities"}>, @traffic_source_deckhand=#<Ahoy::Deckhands::TrafficSourceDeckhand:0x00007f51437305f0 @referrer=nil, @referring_domain=nil, @search_keyword=nil>, @utm_parameter_deckhand=#<Ahoy::Deckhands::UtmParameterDeckhand:0x00007f514af87a58 @landing_page="http://cdn.juliaobserver.com/categories/Utilities", @params={"controller"=>"categories", "action"=>"show", "id"=>"Utilities"}, @landing_params={}>, @technology_deckhand=#<Ahoy::Deckhands::TechnologyDeckhand:0x00007f514af86f90 @user_agent="Amazon CloudFront", @agent=#<UserAgentParser::UserAgent Other (Other) (Other)>, @device_type="Desktop">>>, @marked_for_same_origin_verification=true, @_config={}, @_params=<ActionController::Parameters {"controller"=>"categories", "action"=>"show", "id"=>"Utilities"} permitted: false>, @category=#<Category id: 529591, name: "Utilities", created_at: "2023-10-02 05:45:42", updated_at: "2023-10-02 05:45:42">>, "action_dispatch.request.content_type"=>nil, "action_dispatch.request.request_parameters"=>{}, "rack.request.query_string"=>"", "rack.request.query_hash"=>{}, "action_dispatch.request.query_parameters"=>{}, "action_dispatch.request.parameters"=>{"controller"=>"categories", "action"=>"show", "id"=>"Utilities"}, "action_dispatch.request.formats"=>[#<Mime::Type:0x0000564103f50bc8 @synonyms=["application/xhtml+xml"], @symbol=:html, @string="text/html", @hash=-3605809768113858571>], "rack.request.cookie_hash"=>{}, "action_dispatch.cookies"=>#<ActionDispatch::Cookies::CookieJar:0x00007f5127ef90a0 ...>, "action_dispatch.request.unsigned_session_cookie"=>{}}, @filtered_parameters={"controller"=>"categories", "action"=>"show", "id"=>"Utilities"}, @filtered_env=nil, @filtered_path=nil, @protocol="http://", @port=80, @method=nil, @request_method="GET", @remote_ip="64.252.67.9", @original_fullpath="/categories/Utilities", @fullpath="/categories/Utilities", @ip=nil, @headers=#<ActionDispatch::Http::Headers:0x00007f5127efaa18 @req=#<ActionDispatch::Request:0x00007f514b5c08e8 ...>>>, @cookies={"ahoy_visitor"=>"03dd00eb-d3fb-4c6f-8bc1-1c60a9a342d9", "ahoy_visit"=>"eefd94a1-4d60-439a-870b-5adf500a9137"}, @committed=false, @encrypted=#<ActionDispatch::Cookies::EncryptedCookieJar:0x00007f512f75e130 @parent_jar=#<ActionDispatch::Cookies::CookieJar:0x00007f5127ef90a0 ...>, @encryptor=#<ActiveSupport::MessageEncryptor:0x00007f512f75dfc8 @secret="\xE1\xA4\xD1\xA4}e\xA7NG\xA2\xC1Rsp\t\xBA\xCDv\xCE\x94L?l\xD6\xF5z\b\x8C\xD3\xE0\x9A\xB1", @sign_secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @cipher="aes-256-cbc", @verifier=#<ActiveSupport::MessageVerifier:0x00007f512f75df28 @secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @digest="SHA1", @serializer=ActiveSupport::MessageEncryptor::NullSerializer>, @serializer=ActiveSupport::MessageEncryptor::NullSerializer>>, @signed_or_encrypted=#<ActionDispatch::Cookies::EncryptedCookieJar:0x00007f512f75e130 @parent_jar=#<ActionDispatch::Cookies::CookieJar:0x00007f5127ef90a0 ...>, @encryptor=#<ActiveSupport::MessageEncryptor:0x00007f512f75dfc8 @secret="\xE1\xA4\xD1\xA4}e\xA7NG\xA2\xC1Rsp\t\xBA\xCDv\xCE\x94L?l\xD6\xF5z\b\x8C\xD3\xE0\x9A\xB1", @sign_secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @cipher="aes-256-cbc", @verifier=#<ActiveSupport::MessageVerifier:0x00007f512f75df28 @secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @digest="SHA1", @serializer=ActiveSupport::MessageEncryptor::NullSerializer>, @serializer=ActiveSupport::MessageEncryptor::NullSerializer>>>

D, [2023-10-02T07:07:03.498952 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] [PackageSorterJob] [8800b4fe-b404-4fd1-b742-cd1fdc30a53a] ][1m][36mCACHE (0.0ms)][0m ][1m][34mSELECT "categories".* FROM "categories" INNER JOIN "batches" ON "batches"."item_id" = "categories"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "categories"."name" = $3 LIMIT $4][0m [["item_type", "Category"], ["marker", 5699], ["name", "Utilities"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:03.801317 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] [PackageSorterJob] [8800b4fe-b404-4fd1-b742-cd1fdc30a53a] ][1m][36mOrganization Load (209.0ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

I, [2023-10-02T07:07:03.802818 #19776] INFO -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] [ActiveJob] [PackageSorterJob] [8800b4fe-b404-4fd1-b742-cd1fdc30a53a] Performed PackageSorterJob from DelayedJob(default) in 305.79ms

D, [2023-10-02T07:07:04.255836 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35mSQL (226.4ms)][0m ][1m][34mSELECT "packages"."id" AS t0_r0, "packages"."name" AS t0_r1, "packages"."created_at" AS t0_r2, "packages"."updated_at" AS t0_r3, "packages"."description" AS t0_r4, "packages"."homepage" AS t0_r5, "packages"."owner_type" AS t0_r6, "packages"."owner_id" AS t0_r7, "packages"."is_registered" AS t0_r8, "packages"."readme" AS t0_r9, "packages"."readme_type" AS t0_r10, "daters"."id" AS t1_r0, "daters"."created" AS t1_r1, "daters"."updated" AS t1_r2, "daters"."pushed" AS t1_r3, "daters"."package_id" AS t1_r4, "daters"."created_at" AS t1_r5, "daters"."updated_at" AS t1_r6, "daters"."touched" AS t1_r7, "counters"."id" AS t2_r0, "counters"."fork" AS t2_r1, "counters"."stargazer" AS t2_r2, "counters"."open_issue" AS t2_r3, "counters"."package_id" AS t2_r4, "counters"."created_at" AS t2_r5, "counters"."updated_at" AS t2_r6, "counters"."contributor" AS t2_r7, "activities"."id" AS t3_r0, "activities"."commits" AS t3_r1, "activities"."package_id" AS t3_r2, "activities"."created_at" AS t3_r3, "activities"."updated_at" AS t3_r4, "activities"."recent_commit_count" AS t3_r5 FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 INNER JOIN "daters" ON "daters"."package_id" = "packages"."id" INNER JOIN "counters" ON "counters"."package_id" = "packages"."id" INNER JOIN "activities" ON "activities"."package_id" = "packages"."id" INNER JOIN "labels" ON "packages"."id" = "labels"."package_id" WHERE "labels"."category_id" = $2 AND "batches"."marker" = $3 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."is_registered" = $4 ORDER BY counters.stargazer desc LIMIT $5 OFFSET $6][0m [["item_type", "Package"], ["category_id", 529591], ["marker", 5699], ["is_registered", true], ["LIMIT", 30], ["OFFSET", 0]]]

D, [2023-10-02T07:07:04.761824 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35m (491.8ms)][0m ][1m][34mSELECT DISTINCT COUNT(DISTINCT "packages"."id") FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 INNER JOIN "daters" ON "daters"."package_id" = "packages"."id" INNER JOIN "counters" ON "counters"."package_id" = "packages"."id" INNER JOIN "activities" ON "activities"."package_id" = "packages"."id" INNER JOIN "labels" ON "packages"."id" = "labels"."package_id" WHERE "labels"."category_id" = $2 AND "batches"."marker" = $3 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."is_registered" = $4][0m [["item_type", "Package"], ["category_id", 529591], ["marker", 5699], ["is_registered", true]]]

D, [2023-10-02T07:07:05.009805 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (14.6ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:05.011866 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35mSQL (0.5ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414236], ["name", "Viewed: packages#show"], ["properties", "{}"], ["time", 2023-10-02 07:07:04 UTC]]]

D, [2023-10-02T07:07:05.013225 #19776 DEBUG -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] ][1m][35m (1.0ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:05.013624 #19776] INFO -- : [f98afd5f-1323-4cba-a7c7-539a7afa31e7] {:_method=>"GET", :_path=>"/packages/AbstractLattices", :_format=>:html, :_controller=>"PackagesController", :_action=>"show", :_status=>200, :_duration=>6712.56, :_view=>4243.08, :_db=>2345.56, :_time=>2023-10-02 07:06:58 +0000, :short_message=>"[200] GET /packages/AbstractLattices (PackagesController#show)"}

D, [2023-10-02T07:07:05.028184 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][36mCategory Load (18.2ms)][0m ][1m][34mSELECT "categories".* FROM "categories" INNER JOIN "batches" ON "batches"."item_id" = "categories"."id" AND "batches"."item_type" = $1 INNER JOIN "labels" ON "labels"."category_id" = "categories"."id" INNER JOIN "packages" ON "packages"."id" = "labels"."package_id" WHERE "batches"."marker" = $2 AND "packages"."is_registered" = $3 GROUP BY categories.id ORDER BY count(categories.id) desc][0m [["item_type", "Category"], ["marker", 5699], ["is_registered", true]]]

D, [2023-10-02T07:07:05.574756 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][36mRelease Load (505.0ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:07:08.585868 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35m (0.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:08.587635 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35mSQL (0.7ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414237], ["name", "Viewed: categories#show"], ["properties", "{}"], ["time", 2023-10-02 07:07:08 UTC]]]

D, [2023-10-02T07:07:08.593119 #19776 DEBUG -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] ][1m][35m (5.1ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:08.593492 #19776] INFO -- : [2953d6eb-f9ee-4b66-858a-e06b58227833] {:_method=>"GET", :_path=>"/categories/Utilities", :_format=>:html, :_controller=>"CategoriesController", :_action=>"show", :_status=>200, :_duration=>6238.91, :_view=>3518.88, :_db=>2382.17, :_time=>2023-10-02 07:07:02 +0000, :short_message=>"[200] GET /categories/Utilities (CategoriesController#show)"}

D, [2023-10-02T07:07:15.373026 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35m (1.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:15.376053 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35mSQL (1.5ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "53fcf250-a8d7-4f78-aa98-b5a38876acd8"], ["visitor_token", "79f1eca4-c0f0-4bf5-835a-5852c6c25e4a"], ["ip", "64.252.105.45"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/users/faf0"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:07:15 UTC]]]

D, [2023-10-02T07:07:15.377617 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35m (1.1ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:07:15.379023 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] [ActiveJob] ][1m][35m (0.1ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:15.380405 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] [ActiveJob] ][1m][35mSQL (0.4ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: d59ffd60-0842-4eef-ac46-c501fed9322e\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414238\n locale: en\n"], ["run_at", 2023-10-02 07:07:15 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:07:15 UTC], ["updated_at", 2023-10-02 07:07:15 UTC]]]

D, [2023-10-02T07:07:15.381649 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] [ActiveJob] ][1m][35m (0.9ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:15.382070 #19776] INFO -- : [9038b598-0b9c-4913-acb8-186d48de3b19] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: d59ffd60-0842-4eef-ac46-c501fed9322e) to DelayedJob(ahoy) with arguments: #<GlobalID:0x0000564106164cc8 @uri=#<URI::GID gid://julia-observer/Visit/16414238>>

D, [2023-10-02T07:07:15.384287 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][36mUser Load (0.7ms)][0m ][1m][34mSELECT "users".* FROM "users" INNER JOIN "batches" ON "batches"."item_id" = "users"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "users"."name" = $3 LIMIT $4][0m [["item_type", "User"], ["marker", 5699], ["name", "faf0"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:15.393145 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35m (5.4ms)][0m ][1m][34mSELECT COUNT(*) FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1][0m [["user_id", 12720696]]]

D, [2023-10-02T07:07:15.400325 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][36mProfile Load (0.7ms)][0m ][1m][34mSELECT "profiles".* FROM "profiles" WHERE "profiles"."owner_id" = $1 AND "profiles"."owner_type" = $2 LIMIT $3][0m [["owner_id", 12720696], ["owner_type", "User"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:15.409103 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][36mInfo Load (4.4ms)][0m ][1m][34mSELECT "infos".* FROM "infos" WHERE "infos"."owner_id" = $1 AND "infos"."owner_type" = $2 LIMIT $3][0m [["owner_id", 12720696], ["owner_type", "User"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:15.414165 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35m (1.0ms)][0m ][1m][34mSELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1 LIMIT $2) subquery_for_count][0m [["user_id", 12720696], ["LIMIT", 20]]]

D, [2023-10-02T07:07:15.415714 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][36mPackage Load (0.8ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1 ORDER BY contributions.score desc LIMIT $2][0m [["user_id", 12720696], ["LIMIT", 20]]]

D, [2023-10-02T07:07:15.417547 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][36mContribution Load (0.4ms)][0m ][1m][34mSELECT "contributions".* FROM "contributions" WHERE "contributions"."package_id" = 43707569][0m]

D, [2023-10-02T07:07:15.429314 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35mSQL (5.5ms)][0m ][1m][34mSELECT "packages"."id" AS t0_r0, "packages"."name" AS t0_r1, "packages"."created_at" AS t0_r2, "packages"."updated_at" AS t0_r3, "packages"."description" AS t0_r4, "packages"."homepage" AS t0_r5, "packages"."owner_type" AS t0_r6, "packages"."owner_id" AS t0_r7, "packages"."is_registered" AS t0_r8, "packages"."readme" AS t0_r9, "packages"."readme_type" AS t0_r10, "counters"."id" AS t1_r0, "counters"."fork" AS t1_r1, "counters"."stargazer" AS t1_r2, "counters"."open_issue" AS t1_r3, "counters"."package_id" AS t1_r4, "counters"."created_at" AS t1_r5, "counters"."updated_at" AS t1_r6, "counters"."contributor" AS t1_r7 FROM "packages" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "packages"."owner_id" = $1 AND "packages"."owner_type" = $2 ORDER BY counters.stargazer desc][0m [["owner_id", 12720696], ["owner_type", "User"]]]

D, [2023-10-02T07:07:15.759140 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][36mRelease Load (314.3ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:07:18.738894 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35m (4.5ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:18.740562 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35mSQL (0.5ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414238], ["name", "Viewed: users#show"], ["properties", "{}"], ["time", 2023-10-02 07:07:18 UTC]]]

D, [2023-10-02T07:07:18.744987 #19776 DEBUG -- : [9038b598-0b9c-4913-acb8-186d48de3b19] ][1m][35m (4.0ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:18.745420 #19776] INFO -- : [9038b598-0b9c-4913-acb8-186d48de3b19] {:_method=>"GET", :_path=>"/users/faf0", :_format=>:html, :_controller=>"UsersController", :_action=>"show", :_status=>200, :_duration=>3378.71, :_view=>3011.99, :_db=>347.21, :_time=>2023-10-02 07:07:15 +0000, :short_message=>"[200] GET /users/faf0 (UsersController#show)"}

D, [2023-10-02T07:07:36.437579 #19776] DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ahoy] Visit excluded

I, [2023-10-02T07:07:36.444543 #19776] INFO -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ActiveJob] [PackageSorterJob] [58894dfe-51c9-466a-b75a-57d73e6919d6] Performing PackageSorterJob from DelayedJob(default) with arguments: {"depended_id"=>"PMTK3BookDemos", "page"=>"53", "controller"=>"packages", "action"=>"index"}, #<ActionDispatch::Cookies::CookieJar:0x00007f511f062800 @set_cookies={"ahoy_visitor"=>{:value=>"d7b80b1b-b353-456c-937f-231ac241724b", :expires=>Thu, 02 Oct 2025 07:07:36 UTC +00:00, :domain=>".juliaobserver.com", :path=>"/"}, "ahoy_visit"=>{:value=>"c6886e3a-b678-47ec-a48d-bf037ccdc682", :expires=>Mon, 02 Oct 2023 11:07:36 UTC +00:00, :domain=>".juliaobserver.com", :path=>"/"}}, @delete_cookies={}, @request=#<ActionDispatch::Request:0x00007f511f066a18 @env={"rack.version"=>[1, 3], "rack.errors"=>#<IO:<STDERR>>, "rack.multithread"=>true, "rack.multiprocess"=>false, "rack.run_once"=>false, "SCRIPT_NAME"=>"", "QUERY_STRING"=>"depended_id=PMTK3BookDemos&page=53", "SERVER_PROTOCOL"=>"HTTP/1.1", "SERVER_SOFTWARE"=>"puma 3.12.1 Llamas in Pajamas", "GATEWAY_INTERFACE"=>"CGI/1.2", "REQUEST_METHOD"=>"GET", "REQUEST_PATH"=>"/packages", "REQUEST_URI"=>"/packages?depended_id=PMTK3BookDemos&page=53", "HTTP_VERSION"=>"HTTP/1.0", "HTTP_HOST"=>"cdn.juliaobserver.com", "HTTP_X_REAL_IP"=>"85.208.96.201", "HTTP_X_FORWARDED_FOR"=>"85.208.96.201", "HTTP_X_FORWARDED_PROTO"=>"http", "HTTP_CONNECTION"=>"close", "HTTP_ACCEPT"=>"text/html, application/rss+xml, application/atom+xml, text/xml, text/rss+xml, application/xhtml+xml", "HTTP_ACCEPT_ENCODING"=>"gzip,deflate", "HTTP_USER_AGENT"=>"Mozilla/5.0 (compatible; SemrushBot/7~bl; +http://www.semrush.com/bot.html)", "SERVER_NAME"=>"cdn.juliaobserver.com", "SERVER_PORT"=>"80", "PATH_INFO"=>"/packages", "REMOTE_ADDR"=>"127.0.0.1", "puma.socket"=>#<TCPSocket:fd 13, AF_INET, 127.0.0.1, 3000>, "rack.hijack?"=>true, "rack.hijack"=>#<Puma::Client:0x3fa88f834e0c @ready=true>, "rack.input"=>#<Puma::NullIO:0x00005641027cd960>, "rack.url_scheme"=>"http", "rack.after_reply"=>[], "puma.config"=>#<Puma::Configuration:0x000056410293b8d8 @options=#<Puma::UserFileDefaultOptions:0x000056410293b6f8 @user_options={:environment=>"production"}, @file_options={:min_threads=>5, :max_threads=>5, :binds=>["tcp://0.0.0.0:3000"], :environment=>"production"}, @default_options={:min_threads=>0, :max_threads=>16, :log_requests=>false, :debug=>false, :binds=>["tcp://0.0.0.0:9292"], :workers=>0, :daemon=>false, :mode=>:http, :worker_timeout=>60, :worker_boot_timeout=>60, :worker_shutdown_timeout=>30, :remote_address=>:socket, :tag=>"julia_observer", :environment=>"production", :rackup=>"config.ru", :logger=>#<IO:<STDOUT>>, :persistent_timeout=>20, :first_data_timeout=>30}>, @plugins=#<Puma::PluginLoader:0x000056410293b6a8 @instances=[#<#<Class:0x000056410297b898>:0x000056410297b7d0 @loader=Puma::Plugin>]>, @user_dsl=#<Puma::DSL:0x000056410293b658 @config=#<Puma::Configuration:0x000056410293b8d8 ...>, @options={:environment=>"production"}, @plugins=[]>, @file_dsl=#<Puma::DSL:0x000056410293b608 @config=#<Puma::Configuration:0x000056410293b8d8 ...>, @options={:min_threads=>5, :max_threads=>5, :binds=>["tcp://0.0.0.0:3000"], :environment=>"production"}, @plugins=[], @path="config/puma.rb">, @default_dsl=#<Puma::DSL:0x000056410293b5b8 @config=#<Puma::Configuration:0x000056410293b8d8 ...>, @options={:min_threads=>0, :max_threads=>16, :log_requests=>false, :debug=>false, :binds=>["tcp://0.0.0.0:9292"], :workers=>0, :daemon=>false, :mode=>:http, :worker_timeout=>60, :worker_boot_timeout=>60, :worker_shutdown_timeout=>30, :remote_address=>:socket, :tag=>"julia_observer", :environment=>"production", :rackup=>"config.ru", :logger=>#<IO:<STDOUT>>, :persistent_timeout=>20, :first_data_timeout=>30}, @plugins=[]>>, "action_dispatch.parameter_filter"=>[:password], "action_dispatch.redirect_filter"=>[], "action_dispatch.secret_token"=>nil, "action_dispatch.secret_key_base"=>"4fba9bb4f507809b538fbfaec3d81791ceb10d67c2c41396d13713d6c9e2fbbe936e079ab7efaad736ac19f965e1e7b8811c20c0b159ecab2c3cf24e88dccdd5", "action_dispatch.show_exceptions"=>true, "action_dispatch.show_detailed_exceptions"=>true, "action_dispatch.logger"=>#<ActiveSupport::Logger:0x000056410516d108 @level=0, @progname=nil, @default_formatter=#<Logger::Formatter:0x000056410516d090 @datetime_format=nil>, @formatter=#<Logger::Formatter:0x000056410516db58 @datetime_format=nil, @thread_key="activesupport_tagged_logging_tags:47418629123500">, @logdev=#<Logger::LogDevice:0x000056410516d040 @shift_period_suffix=nil, @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<File:/home/rails/julia_observer/log/production.log>, @mon_mutex=#<Thread::Mutex:0x000056410516cff0>, @mon_mutex_owner_object_id=47418629122080, @mon_owner=nil, @mon_count=0>, @local_levels=#<Concurrent::Map:0x000056410516cf28 entries=0 default_proc=nil>, @thread_hash_level_key=:"ThreadSafeLogger#47418629122180@level">, "action_dispatch.backtrace_cleaner"=>#<Rails::BacktraceCleaner:0x0000564103eaebc0 @filters=[#<Proc:0x0000564103eae918@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:14>, #<Proc:0x0000564103eae8f0@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:15>, #<Proc:0x0000564103eae850@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:16>, #<Proc:0x0000564103ed6e40@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:29>], @silencers=[#<Proc:0x0000564103ed6dc8@/home/rails/.rvm/gems/ruby-2.6.3/gems/railties-5.0.1.rc2/lib/rails/backtrace_cleaner.rb:19>], @root="/home/rails/julia_observer/">, "action_dispatch.key_generator"=>#<ActiveSupport::CachingKeyGenerator:0x0000564104ed87d0 @key_generator=#<ActiveSupport::KeyGenerator:0x0000564104ed87f8 @secret="4fba9bb4f507809b538fbfaec3d81791ceb10d67c2c41396d13713d6c9e2fbbe936e079ab7efaad736ac19f965e1e7b8811c20c0b159ecab2c3cf24e88dccdd5", @iterations=1000>, @cache_keys=#<Concurrent::Map:0x0000564104ed87a8 entries=3 default_proc=nil>>, "action_dispatch.http_auth_salt"=>"http authentication", "action_dispatch.signed_cookie_salt"=>"signed cookie", "action_dispatch.encrypted_cookie_salt"=>"encrypted cookie", "action_dispatch.encrypted_signed_cookie_salt"=>"signed encrypted cookie", "action_dispatch.cookies_serializer"=>:json, "action_dispatch.cookies_digest"=>nil, "action_dispatch.routes"=>#<ActionDispatch::Routing::RouteSet:0x0000564105077708>, "ROUTES_47418628619140_SCRIPT_NAME"=>"", "ORIGINAL_FULLPATH"=>"/packages?depended_id=PMTK3BookDemos&page=53", "ORIGINAL_SCRIPT_NAME"=>"", "rack.cors"=>#<Rack::Cors::Result:0x00007f511f069650 @preflight=false, @hit=false, @miss_reason="no-origin">, "action_dispatch.request_id"=>"b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4", "action_dispatch.remote_ip"=>#<ActionDispatch::RemoteIp::GetIp:0x00007f511f068ae8 @req=#<ActionDispatch::Request:0x00007f511f068b10 @env={...}, @filtered_parameters=nil, @filtered_env=nil, @filtered_path=nil, @protocol=nil, @port=nil, @method=nil, @request_method=nil, @remote_ip=nil, @original_fullpath=nil, @fullpath=nil, @ip=nil>, @check_ip=true, @proxies=[#<IPAddr: IPv4:127.0.0.1/255.255.255.255>, #<IPAddr: IPv6:0000:0000:0000:0000:0000:0000:0000:0001/ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff>, #<IPAddr: IPv6:fc00:0000:0000:0000:0000:0000:0000:0000/fe00:0000:0000:0000:0000:0000:0000:0000>, #<IPAddr: IPv4:10.0.0.0/255.0.0.0>, #<IPAddr: IPv4:172.16.0.0/255.240.0.0>, #<IPAddr: IPv4:192.168.0.0/255.255.0.0>]>, "rack.session"=>#<ActionDispatch::Request::Session:0x7f511f068a20 not yet loaded>, "rack.session.options"=>#<ActionDispatch::Request::Session::Options:0x00007f511f0689d0 @by=#<ActionDispatch::Session::CookieStore:0x000056410615b5d8 @app=#<Rack::Head:0x000056410615b600 @app=#<Rack::ConditionalGet:0x000056410615b628 @app=#<Rack::ETag:0x000056410615b650 @app=#<Rack::Attack:0x000056410615b678 @app=#<Ahoy::Throttle:0x000056410615b6a0 @app=#<ActionDispatch::Routing::RouteSet:0x0000564105077708>>>, @cache_control="max-age=0, private, must-revalidate", @no_cache_control="no-cache">>>, @default_options={:path=>"/", :domain=>nil, :expire_after=>nil, :secure=>false, :httponly=>true, :defer=>false, :renew=>false}, @key="_julia_observer_session", @cookie_only=true>, @delegate={:path=>"/", :domain=>nil, :expire_after=>nil, :secure=>false, :httponly=>true, :defer=>false, :renew=>false}>, "rack.attack.throttle_data"=>{"req/ip"=>{:count=>1, :period=>300, :limit=>500, :epoch_time=>1696230456}}, "action_dispatch.request.path_parameters"=>{:controller=>"packages", :action=>"index"}, "action_controller.instance"=>#<PackagesController:0x00007f511f065b90 @_action_has_layout=true, @_routes=nil, @_request=#<ActionDispatch::Request:0x00007f511f066a18 ...>, @_response=#<ActionDispatch::Response:0x00007f511f065dc0 @mon_mutex=#<Thread::Mutex:0x00007f511f065d48>, @mon_mutex_owner_object_id=69993194794720, @mon_owner=nil, @mon_count=0, @header={"X-Frame-Options"=>"SAMEORIGIN", "X-XSS-Protection"=>"1; mode=block", "X-Content-Type-Options"=>"nosniff"}, @stream=#<ActionDispatch::Response::Buffer:0x00007f511f065cf8 @response=#<ActionDispatch::Response:0x00007f511f065dc0 ...>, @buf=[], @closed=false, @str_body=nil>, @status=200, @cv=#<MonitorMixin::ConditionVariable:0x00007f511f065cd0 @monitor=#<ActionDispatch::Response:0x00007f511f065dc0 ...>, @cond=#<Thread::ConditionVariable:0x00007f511f065ca8>>, @committed=false, @sending=false, @sent=false, @cache_control={}, @request=#<ActionDispatch::Request:0x00007f511f066a18 ...>>, @_lookup_context=#<ActionView::LookupContext:0x00007f511f065aa0 @details_key=nil, @cache=true, @prefixes=["packages", "application"], @rendered_format=nil, @details={:locale=>[:en], :formats=>[:html, :rss, :atom, :xml, "text/rss+xml"], :variants=>[], :handlers=>[:raw, :erb, :html, :builder, :ruby, :coffee, :jbuilder]}, @view_paths=#<ActionView::PathSet:0x00007f511f065988 @paths=[#<ActionView::OptimizedFileSystemResolver:0x0000564105156cc8 @pattern=":prefix/:action{.:locale,}{.:formats,}{+:variants,}{.:handlers,}", @cache=#<ActionView::Resolver::Cache:0x564105156ca0 keys=336 queries=0>, @path="/home/rails/julia_observer/app/views">]>>, @_action_name="index", @_response_body=nil, @ahoy=#<Ahoy::Tracker:0x00007f511f063890 @store=#<Ahoy::Store:0x00007f511f063818 @options={:controller=>#<PackagesController:0x00007f511f065b90 ...>, :ahoy=>#<Ahoy::Tracker:0x00007f511f063890 ...>}, @controller=#<PackagesController:0x00007f511f065b90 ...>, @request=#<ActionDispatch::Request:0x00007f511f066a18 ...>, @bot=true>, @controller=#<PackagesController:0x00007f511f065b90 ...>, @request=#<ActionDispatch::Request:0x00007f511f066a18 ...>, @options={:controller=>#<PackagesController:0x00007f511f065b90 ...>}, @visitor_header=nil, @visitor_cookie=nil, @existing_visitor_token=nil, @visitor_token_helper="d7b80b1b-b353-456c-937f-231ac241724b", @visitor_id="d7b80b1b-b353-456c-937f-231ac241724b", @visit_header=nil, @visit_cookie=nil, @existing_visit_token=nil, @visit_token_helper="c6886e3a-b678-47ec-a48d-bf037ccdc682", @visit_id="c6886e3a-b678-47ec-a48d-bf037ccdc682">, @marked_for_same_origin_verification=true, @_config={}, @_params=<ActionController::Parameters {"depended_id"=>"PMTK3BookDemos", "page"=>"53", "controller"=>"packages", "action"=>"index"} permitted: false>>, "action_dispatch.request.content_type"=>nil, "action_dispatch.request.request_parameters"=>{}, "rack.request.query_string"=>"depended_id=PMTK3BookDemos&page=53", "rack.request.query_hash"=>{"depended_id"=>"PMTK3BookDemos", "page"=>"53"}, "action_dispatch.request.query_parameters"=>{"depended_id"=>"PMTK3BookDemos", "page"=>"53"}, "action_dispatch.request.parameters"=>{"depended_id"=>"PMTK3BookDemos", "page"=>"53", "controller"=>"packages", "action"=>"index"}, "action_dispatch.request.accepts"=>[#<Mime::Type:0x0000564103f50bc8 @synonyms=["application/xhtml+xml"], @symbol=:html, @string="text/html", @hash=-3605809768113858571>, #<Mime::Type:0x0000564103f73178 @synonyms=[], @symbol=:rss, @string="application/rss+xml", @hash=-1204026609759973205>, #<Mime::Type:0x0000564103f72fe8 @synonyms=[], @symbol=:atom, @string="application/atom+xml", @hash=1077626209524918452>, #<Mime::Type:0x0000564103f73308 @synonyms=["text/xml", "application/x-xml"], @symbol=:xml, @string="application/xml", @hash=-4384402365913664919>, #<Mime::Type:0x00007f511f063d18 @synonyms=[], @symbol=nil, @string="text/rss+xml", @hash=2388605070006657103>], "action_dispatch.request.formats"=>[#<Mime::Type:0x0000564103f50bc8 @synonyms=["application/xhtml+xml"], @symbol=:html, @string="text/html", @hash=-3605809768113858571>, #<Mime::Type:0x0000564103f73178 @synonyms=[], @symbol=:rss, @string="application/rss+xml", @hash=-1204026609759973205>, #<Mime::Type:0x0000564103f72fe8 @synonyms=[], @symbol=:atom, @string="application/atom+xml", @hash=1077626209524918452>, #<Mime::Type:0x0000564103f73308 @synonyms=["text/xml", "application/x-xml"], @symbol=:xml, @string="application/xml", @hash=-4384402365913664919>, #<Mime::Type:0x00007f511f063d18 @synonyms=[], @symbol=nil, @string="text/rss+xml", @hash=2388605070006657103>], "rack.request.cookie_hash"=>{}, "action_dispatch.cookies"=>#<ActionDispatch::Cookies::CookieJar:0x00007f511f062800 ...>, "action_dispatch.request.unsigned_session_cookie"=>{}}, @filtered_parameters={"depended_id"=>"PMTK3BookDemos", "page"=>"53", "controller"=>"packages", "action"=>"index"}, @filtered_env=nil, @filtered_path=nil, @protocol=nil, @port=nil, @method=nil, @request_method="GET", @remote_ip=nil, @original_fullpath=nil, @fullpath="/packages?depended_id=PMTK3BookDemos&page=53", @ip=nil, @headers=#<ActionDispatch::Http::Headers:0x00007f511f0646a0 @req=#<ActionDispatch::Request:0x00007f511f066a18 ...>>>, @cookies={"ahoy_visitor"=>"d7b80b1b-b353-456c-937f-231ac241724b", "ahoy_visit"=>"c6886e3a-b678-47ec-a48d-bf037ccdc682"}, @committed=false, @encrypted=#<ActionDispatch::Cookies::EncryptedCookieJar:0x00007f511f060258 @parent_jar=#<ActionDispatch::Cookies::CookieJar:0x00007f511f062800 ...>, @encryptor=#<ActiveSupport::MessageEncryptor:0x00007f511f0600f0 @secret="\xE1\xA4\xD1\xA4}e\xA7NG\xA2\xC1Rsp\t\xBA\xCDv\xCE\x94L?l\xD6\xF5z\b\x8C\xD3\xE0\x9A\xB1", @sign_secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @cipher="aes-256-cbc", @verifier=#<ActiveSupport::MessageVerifier:0x00007f511f060050 @secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @digest="SHA1", @serializer=ActiveSupport::MessageEncryptor::NullSerializer>, @serializer=ActiveSupport::MessageEncryptor::NullSerializer>>, @signed_or_encrypted=#<ActionDispatch::Cookies::EncryptedCookieJar:0x00007f511f060258 @parent_jar=#<ActionDispatch::Cookies::CookieJar:0x00007f511f062800 ...>, @encryptor=#<ActiveSupport::MessageEncryptor:0x00007f511f0600f0 @secret="\xE1\xA4\xD1\xA4}e\xA7NG\xA2\xC1Rsp\t\xBA\xCDv\xCE\x94L?l\xD6\xF5z\b\x8C\xD3\xE0\x9A\xB1", @sign_secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @cipher="aes-256-cbc", @verifier=#<ActiveSupport::MessageVerifier:0x00007f511f060050 @secret="\x01\xA6\e\x9C)\xA0\xB0o\xCA\xC9\x83\r\xE0\xE0\xF2)\xCCxY\e1\v\xC0\x04\x95\x92\xDF\xF7\x19b\xD2d[}\xC8\x88\xB5E$\xE6i\xA2\x97d\x18c\x01\xD0\x99\x81xU#<\x89\xBB)\xC7\x93J\xF1\xCCfd", @digest="SHA1", @serializer=ActiveSupport::MessageEncryptor::NullSerializer>, @serializer=ActiveSupport::MessageEncryptor::NullSerializer>>>

D, [2023-10-02T07:07:36.457121 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ActiveJob] [PackageSorterJob] [58894dfe-51c9-466a-b75a-57d73e6919d6] ][1m][36mOrganization Load (5.9ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:37.522806 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ActiveJob] [PackageSorterJob] [58894dfe-51c9-466a-b75a-57d73e6919d6] ][1m][36mPackage Load (1063.9ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."name" = $3 LIMIT $4][0m [["item_type", "Package"], ["marker", 5699], ["name", "PMTK3BookDemos"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:37.524564 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ActiveJob] [PackageSorterJob] [58894dfe-51c9-466a-b75a-57d73e6919d6] ][1m][36mCACHE (0.1ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:37.574892 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ActiveJob] [PackageSorterJob] [58894dfe-51c9-466a-b75a-57d73e6919d6] ][1m][36mPackage Load (49.1ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND (name ILIKE '%PMTK3BookDemos%')][0m [["item_type", "Package"], ["marker", 5699]]]

D, [2023-10-02T07:07:37.576483 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ActiveJob] [PackageSorterJob] [58894dfe-51c9-466a-b75a-57d73e6919d6] ][1m][36mCACHE (0.0ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

I, [2023-10-02T07:07:37.577254 #19776] INFO -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ActiveJob] [PackageSorterJob] [58894dfe-51c9-466a-b75a-57d73e6919d6] Performed PackageSorterJob from DelayedJob(default) in 1128.39ms

D, [2023-10-02T07:07:38.102852 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35m (0.1ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:38.106026 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35mSQL (1.5ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "3eef4401-ce74-4a08-920a-6792d7a5bb39"], ["visitor_token", "3516a1d5-4222-44d5-aca7-e3f733ea342e"], ["ip", "64.252.104.213"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/users/1oly"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:07:38 UTC]]]

D, [2023-10-02T07:07:38.114274 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35m (7.6ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:07:38.115936 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] [ActiveJob] ][1m][35m (0.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:38.117501 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] [ActiveJob] ][1m][35mSQL (0.5ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: 30ed5c19-64a6-449c-9a56-10b798c97a42\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414239\n locale: en\n"], ["run_at", 2023-10-02 07:07:38 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:07:38 UTC], ["updated_at", 2023-10-02 07:07:38 UTC]]]

D, [2023-10-02T07:07:38.118683 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] [ActiveJob] ][1m][35m (0.8ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:38.119024 #19776] INFO -- : [3e229b89-7b75-46aa-8615-71cde1370c85] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: 30ed5c19-64a6-449c-9a56-10b798c97a42) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f5143cf1a98 @uri=#<URI::GID gid://julia-observer/Visit/16414239>>

D, [2023-10-02T07:07:38.129853 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][36mUser Load (8.9ms)][0m ][1m][34mSELECT "users".* FROM "users" INNER JOIN "batches" ON "batches"."item_id" = "users"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "users"."name" = $3 LIMIT $4][0m [["item_type", "User"], ["marker", 5699], ["name", "1oly"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:38.134977 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35m (0.9ms)][0m ][1m][34mSELECT COUNT(*) FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1][0m [["user_id", 12720729]]]

D, [2023-10-02T07:07:38.149636 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][36mProfile Load (8.6ms)][0m ][1m][34mSELECT "profiles".* FROM "profiles" WHERE "profiles"."owner_id" = $1 AND "profiles"."owner_type" = $2 LIMIT $3][0m [["owner_id", 12720729], ["owner_type", "User"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:38.161058 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][36mInfo Load (5.1ms)][0m ][1m][34mSELECT "infos".* FROM "infos" WHERE "infos"."owner_id" = $1 AND "infos"."owner_type" = $2 LIMIT $3][0m [["owner_id", 12720729], ["owner_type", "User"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:38.178058 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35m (8.0ms)][0m ][1m][34mSELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1 LIMIT $2) subquery_for_count][0m [["user_id", 12720729], ["LIMIT", 20]]]

D, [2023-10-02T07:07:38.179872 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][36mPackage Load (0.9ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1 ORDER BY contributions.score desc LIMIT $2][0m [["user_id", 12720729], ["LIMIT", 20]]]

D, [2023-10-02T07:07:38.181720 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][36mContribution Load (0.4ms)][0m ][1m][34mSELECT "contributions".* FROM "contributions" WHERE "contributions"."package_id" IN (43707079, 43705825)][0m]

D, [2023-10-02T07:07:38.187707 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35mSQL (0.9ms)][0m ][1m][34mSELECT "packages"."id" AS t0_r0, "packages"."name" AS t0_r1, "packages"."created_at" AS t0_r2, "packages"."updated_at" AS t0_r3, "packages"."description" AS t0_r4, "packages"."homepage" AS t0_r5, "packages"."owner_type" AS t0_r6, "packages"."owner_id" AS t0_r7, "packages"."is_registered" AS t0_r8, "packages"."readme" AS t0_r9, "packages"."readme_type" AS t0_r10, "counters"."id" AS t1_r0, "counters"."fork" AS t1_r1, "counters"."stargazer" AS t1_r2, "counters"."open_issue" AS t1_r3, "counters"."package_id" AS t1_r4, "counters"."created_at" AS t1_r5, "counters"."updated_at" AS t1_r6, "counters"."contributor" AS t1_r7 FROM "packages" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "packages"."owner_id" = $1 AND "packages"."owner_type" = $2 ORDER BY counters.stargazer desc][0m [["owner_id", 12720729], ["owner_type", "User"]]]

D, [2023-10-02T07:07:38.676844 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] ][1m][35mSQL (1097.4ms)][0m ][1m][34mSELECT "packages"."id" AS t0_r0, "packages"."name" AS t0_r1, "packages"."created_at" AS t0_r2, "packages"."updated_at" AS t0_r3, "packages"."description" AS t0_r4, "packages"."homepage" AS t0_r5, "packages"."owner_type" AS t0_r6, "packages"."owner_id" AS t0_r7, "packages"."is_registered" AS t0_r8, "packages"."readme" AS t0_r9, "packages"."readme_type" AS t0_r10, "daters"."id" AS t1_r0, "daters"."created" AS t1_r1, "daters"."updated" AS t1_r2, "daters"."pushed" AS t1_r3, "daters"."package_id" AS t1_r4, "daters"."created_at" AS t1_r5, "daters"."updated_at" AS t1_r6, "daters"."touched" AS t1_r7, "counters"."id" AS t2_r0, "counters"."fork" AS t2_r1, "counters"."stargazer" AS t2_r2, "counters"."open_issue" AS t2_r3, "counters"."package_id" AS t2_r4, "counters"."created_at" AS t2_r5, "counters"."updated_at" AS t2_r6, "counters"."contributor" AS t2_r7, "activities"."id" AS t3_r0, "activities"."commits" AS t3_r1, "activities"."package_id" AS t3_r2, "activities"."created_at" AS t3_r3, "activities"."updated_at" AS t3_r4, "activities"."recent_commit_count" AS t3_r5 FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 INNER JOIN "daters" ON "daters"."package_id" = "packages"."id" INNER JOIN "counters" ON "counters"."package_id" = "packages"."id" INNER JOIN "activities" ON "activities"."package_id" = "packages"."id" WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."is_registered" = $3 ORDER BY counters.stargazer desc LIMIT $4 OFFSET $5][0m [["item_type", "Package"], ["marker", 5699], ["is_registered", true], ["LIMIT", 30], ["OFFSET", 1560]]]

D, [2023-10-02T07:07:38.714108 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] ][1m][36mCategory Load (17.7ms)][0m ][1m][34mSELECT "categories".* FROM "categories" INNER JOIN "batches" ON "batches"."item_id" = "categories"."id" AND "batches"."item_type" = $1 INNER JOIN "labels" ON "labels"."category_id" = "categories"."id" INNER JOIN "packages" ON "packages"."id" = "labels"."package_id" WHERE "batches"."marker" = $2 AND "packages"."is_registered" = $3 GROUP BY categories.id ORDER BY count(categories.id) desc][0m [["item_type", "Category"], ["marker", 5699], ["is_registered", true]]]

D, [2023-10-02T07:07:39.087029 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][36mRelease Load (885.2ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:07:40.548619 #19776 DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] ][1m][36mRelease Load (1814.6ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:07:42.766294 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35m (100.0ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:42.973153 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35mSQL (105.4ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "ffd72c70-5bce-43be-b6ad-57ea39bf8c29"], ["visitor_token", "e15086f8-8275-4086-92cc-81fc13a20ebf"], ["ip", "64.252.67.9"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/packages/AMD"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:07:42 UTC]]]

D, [2023-10-02T07:07:43.081064 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35m (107.3ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:07:43.189093 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] [ActiveJob] ][1m][35m (106.5ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:43.297858 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] [ActiveJob] ][1m][35mSQL (107.1ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: 6df66f18-3976-46c9-b4e3-89366a41fc65\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414240\n locale: en\n"], ["run_at", 2023-10-02 07:07:43 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:07:43 UTC], ["updated_at", 2023-10-02 07:07:43 UTC]]]

D, [2023-10-02T07:07:43.691554 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] [ActiveJob] ][1m][35m (393.1ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:43.692001 #19776] INFO -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: 6df66f18-3976-46c9-b4e3-89366a41fc65) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f5138e32e80 @uri=#<URI::GID gid://julia-observer/Visit/16414240>>

D, [2023-10-02T07:07:43.801747 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mOrganization Load (106.7ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" INNER JOIN "batches" ON "batches"."item_id" = "organizations"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "organizations"."name" = $3 LIMIT $4][0m [["item_type", "Organization"], ["marker", 5699], ["name", "UnofficialJuliaMirror"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:44.211738 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35m (152.8ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:44.313904 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35mSQL (100.7ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414239], ["name", "Viewed: users#show"], ["properties", "{}"], ["time", 2023-10-02 07:07:44 UTC]]]

D, [2023-10-02T07:07:44.415567 #19776 DEBUG -- : [3e229b89-7b75-46aa-8615-71cde1370c85] ][1m][35m (101.1ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:44.416040 #19776] INFO -- : [3e229b89-7b75-46aa-8615-71cde1370c85] {:_method=>"GET", :_path=>"/users/1oly", :_format=>:html, :_controller=>"UsersController", :_action=>"show", :_status=>200, :_duration=>6318.12, :_view=>5012.75, :_db=>1284.19, :_time=>2023-10-02 07:07:38 +0000, :short_message=>"[200] GET /users/1oly (UsersController#show)"}

D, [2023-10-02T07:07:45.123916 #19776] DEBUG -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] [ahoy] Event excluded

I, [2023-10-02T07:07:45.124240 #19776] INFO -- : [b6e2e5af-5bae-42c9-b7c2-4ffdbdc979e4] {:_method=>"GET", :_path=>"/packages", :_format=>:html, :_controller=>"PackagesController", :_action=>"index", :_status=>200, :_duration=>8687.47, :_view=>4612.97, :_db=>4048.74, :_time=>2023-10-02 07:07:36 +0000, :short_message=>"[200] GET /packages (PackagesController#index)"}

D, [2023-10-02T07:07:45.671470 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mPackage Load (1868.0ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "batches" ON "batches"."item_id" = "packages"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND (NOT (owner_id = 1028496 and owner_type = 'Organization')) AND "packages"."name" = $3 LIMIT $4][0m [["item_type", "Package"], ["marker", 5699], ["name", "AMD"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:45.674901 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mContribution Load (0.6ms)][0m ][1m][34mSELECT "contributions".* FROM "contributions" WHERE "contributions"."package_id" = $1 ORDER BY "contributions"."score" DESC LIMIT $2][0m [["package_id", 43705291], ["LIMIT", 20]]]

D, [2023-10-02T07:07:45.681040 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mUser Load (4.2ms)][0m ][1m][34mSELECT "users".* FROM "users" WHERE "users"."id" IN (12720685, 12720850, 12720647, 12720679, 12720864, 12720831, 12720639, 12720723, 12720793, 12720871)][0m]

D, [2023-10-02T07:07:45.689861 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mRepository Load (1.4ms)][0m ][1m][34mSELECT "repositories".* FROM "repositories" WHERE "repositories"."package_id" = $1 LIMIT $2][0m [["package_id", 43705291], ["LIMIT", 1]]]

D, [2023-10-02T07:07:45.696797 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mCounter Load (3.9ms)][0m ][1m][34mSELECT "counters".* FROM "counters" WHERE "counters"."package_id" = $1 LIMIT $2][0m [["package_id", 43705291], ["LIMIT", 1]]]

D, [2023-10-02T07:07:45.704971 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mDater Load (0.8ms)][0m ][1m][34mSELECT "daters".* FROM "daters" WHERE "daters"."package_id" = $1 LIMIT $2][0m [["package_id", 43705291], ["LIMIT", 1]]]

D, [2023-10-02T07:07:45.706842 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mContribution Load (0.4ms)][0m ][1m][34mSELECT "contributions".* FROM "contributions" WHERE "contributions"."package_id" = $1][0m [["package_id", 43705291]]]

D, [2023-10-02T07:07:45.726974 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35mSQL (1.4ms)][0m ][1m][34mSELECT "dependencies"."id" AS t0_r0, "dependencies"."dependent_id" AS t0_r1, "dependencies"."depended_id" AS t0_r2, "dependencies"."created_at" AS t0_r3, "dependencies"."updated_at" AS t0_r4, "dependencies"."is_shallow" AS t0_r5, "packages"."id" AS t1_r0, "packages"."name" AS t1_r1, "packages"."created_at" AS t1_r2, "packages"."updated_at" AS t1_r3, "packages"."description" AS t1_r4, "packages"."homepage" AS t1_r5, "packages"."owner_type" AS t1_r6, "packages"."owner_id" AS t1_r7, "packages"."is_registered" AS t1_r8, "packages"."readme" AS t1_r9, "packages"."readme_type" AS t1_r10, "counters"."id" AS t2_r0, "counters"."fork" AS t2_r1, "counters"."stargazer" AS t2_r2, "counters"."open_issue" AS t2_r3, "counters"."package_id" AS t2_r4, "counters"."created_at" AS t2_r5, "counters"."updated_at" AS t2_r6, "counters"."contributor" AS t2_r7 FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."depended_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."dependent_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AMD')) AND "packages"."is_registered" = $2 ORDER BY "dependencies"."is_shallow" DESC, counters.stargazer desc][0m [["dependent_id", 43705291], ["is_registered", true]]]

D, [2023-10-02T07:07:45.732466 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35mSQL (2.3ms)][0m ][1m][34mSELECT "dependencies"."id" AS t0_r0, "dependencies"."dependent_id" AS t0_r1, "dependencies"."depended_id" AS t0_r2, "dependencies"."created_at" AS t0_r3, "dependencies"."updated_at" AS t0_r4, "dependencies"."is_shallow" AS t0_r5, "packages"."id" AS t1_r0, "packages"."name" AS t1_r1, "packages"."created_at" AS t1_r2, "packages"."updated_at" AS t1_r3, "packages"."description" AS t1_r4, "packages"."homepage" AS t1_r5, "packages"."owner_type" AS t1_r6, "packages"."owner_id" AS t1_r7, "packages"."is_registered" AS t1_r8, "packages"."readme" AS t1_r9, "packages"."readme_type" AS t1_r10, "counters"."id" AS t2_r0, "counters"."fork" AS t2_r1, "counters"."stargazer" AS t2_r2, "counters"."open_issue" AS t2_r3, "counters"."package_id" AS t2_r4, "counters"."created_at" AS t2_r5, "counters"."updated_at" AS t2_r6, "counters"."contributor" AS t2_r7 FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."dependent_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."depended_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AMD', 'Cuddle')) AND "packages"."is_registered" = $2 ORDER BY "dependencies"."is_shallow" DESC, counters.stargazer desc][0m [["depended_id", 43705291], ["is_registered", true]]]

D, [2023-10-02T07:07:45.735787 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35m (1.2ms)][0m ][1m][34mSELECT DISTINCT COUNT(DISTINCT "dependencies"."id") FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."depended_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."dependent_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AMD')) AND "packages"."is_registered" = $2][0m [["dependent_id", 43705291], ["is_registered", true]]]

D, [2023-10-02T07:07:45.739053 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35m (1.4ms)][0m ][1m][34mSELECT DISTINCT COUNT(DISTINCT "dependencies"."id") FROM "dependencies" INNER JOIN "packages" ON "packages"."id" = "dependencies"."dependent_id" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "dependencies"."depended_id" = $1 AND ("packages"."name" NOT IN ('Julia', 'AMD', 'Cuddle')) AND "packages"."is_registered" = $2][0m [["depended_id", 43705291], ["is_registered", true]]]

D, [2023-10-02T07:07:45.749112 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mOrganization Load (5.1ms)][0m ][1m][34mSELECT "organizations".* FROM "organizations" WHERE "organizations"."id" = $1 LIMIT $2][0m [["id", 1028483], ["LIMIT", 1]]]

D, [2023-10-02T07:07:45.753278 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mActivity Load (0.4ms)][0m ][1m][34mSELECT "activities".* FROM "activities" WHERE "activities"."package_id" = $1 LIMIT $2][0m [["package_id", 43705291], ["LIMIT", 1]]]

D, [2023-10-02T07:07:45.760371 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35m (1.3ms)][0m ][1m][34mSELECT COUNT(*) FROM "versions" WHERE "versions"."package_id" = $1][0m [["package_id", 43705291]]]

D, [2023-10-02T07:07:45.764943 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mVersion Load (1.4ms)][0m ][1m][34mSELECT "versions".* FROM "versions" WHERE "versions"."package_id" = $1 ORDER BY "versions"."major" ASC, "versions"."minor" ASC, "versions"."patch" ASC][0m [["package_id", 43705291]]]

D, [2023-10-02T07:07:46.110175 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][36mRelease Load (323.9ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:07:49.311165 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35m (0.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:49.312704 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35mSQL (0.6ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414240], ["name", "Viewed: packages#show"], ["properties", "{}"], ["time", 2023-10-02 07:07:49 UTC]]]

D, [2023-10-02T07:07:49.317105 #19776 DEBUG -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] ][1m][35m (4.0ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:49.317421 #19776] INFO -- : [a7bbed16-7645-4537-8f3d-c1a9890902f1] {:_method=>"GET", :_path=>"/packages/AMD", :_format=>:html, :_controller=>"PackagesController", :_action=>"show", :_status=>200, :_duration=>6846.0, :_view=>3282.24, :_db=>3248.55, :_time=>2023-10-02 07:07:42 +0000, :short_message=>"[200] GET /packages/AMD (PackagesController#show)"}

D, [2023-10-02T07:07:56.441124 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35m (0.1ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:56.443722 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35mSQL (1.4ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "dfd05e88-0532-4fb2-9e91-67141bd1d172"], ["visitor_token", "4aac07d9-019e-46a7-9f88-0def2e3644eb"], ["ip", "64.252.66.139"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/users/fredrik-johansson"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:07:56 UTC]]]

D, [2023-10-02T07:07:56.444822 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35m (0.7ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:07:56.446099 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] [ActiveJob] ][1m][35m (0.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:56.447935 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] [ActiveJob] ][1m][35mSQL (0.5ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: faaf2ff5-8b64-4a61-a166-431d02571e66\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414241\n locale: en\n"], ["run_at", 2023-10-02 07:07:56 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:07:56 UTC], ["updated_at", 2023-10-02 07:07:56 UTC]]]

D, [2023-10-02T07:07:56.449022 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] [ActiveJob] ][1m][35m (0.7ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:56.449365 #19776] INFO -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: faaf2ff5-8b64-4a61-a166-431d02571e66) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f513d60ad48 @uri=#<URI::GID gid://julia-observer/Visit/16414241>>

D, [2023-10-02T07:07:56.452000 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][36mUser Load (1.1ms)][0m ][1m][34mSELECT "users".* FROM "users" INNER JOIN "batches" ON "batches"."item_id" = "users"."id" AND "batches"."item_type" = $1 WHERE "batches"."marker" = $2 AND "users"."name" = $3 LIMIT $4][0m [["item_type", "User"], ["marker", 5699], ["name", "fredrik-johansson"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:56.461044 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35m (6.1ms)][0m ][1m][34mSELECT COUNT(*) FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1][0m [["user_id", 12720761]]]

D, [2023-10-02T07:07:56.467394 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][36mProfile Load (1.0ms)][0m ][1m][34mSELECT "profiles".* FROM "profiles" WHERE "profiles"."owner_id" = $1 AND "profiles"."owner_type" = $2 LIMIT $3][0m [["owner_id", 12720761], ["owner_type", "User"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:56.471386 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][36mInfo Load (0.4ms)][0m ][1m][34mSELECT "infos".* FROM "infos" WHERE "infos"."owner_id" = $1 AND "infos"."owner_type" = $2 LIMIT $3][0m [["owner_id", 12720761], ["owner_type", "User"], ["LIMIT", 1]]]

D, [2023-10-02T07:07:56.478782 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35m (0.8ms)][0m ][1m][34mSELECT COUNT(count_column) FROM (SELECT 1 AS count_column FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1 LIMIT $2) subquery_for_count][0m [["user_id", 12720761], ["LIMIT", 20]]]

D, [2023-10-02T07:07:56.480047 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][36mPackage Load (0.7ms)][0m ][1m][34mSELECT "packages".* FROM "packages" INNER JOIN "contributions" ON "packages"."id" = "contributions"."package_id" WHERE "contributions"."user_id" = $1 ORDER BY contributions.score desc LIMIT $2][0m [["user_id", 12720761], ["LIMIT", 20]]]

D, [2023-10-02T07:07:56.481871 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][36mContribution Load (0.5ms)][0m ][1m][34mSELECT "contributions".* FROM "contributions" WHERE "contributions"."package_id" IN (43710724, 43705088)][0m]

D, [2023-10-02T07:07:56.497391 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35mSQL (8.3ms)][0m ][1m][34mSELECT "packages"."id" AS t0_r0, "packages"."name" AS t0_r1, "packages"."created_at" AS t0_r2, "packages"."updated_at" AS t0_r3, "packages"."description" AS t0_r4, "packages"."homepage" AS t0_r5, "packages"."owner_type" AS t0_r6, "packages"."owner_id" AS t0_r7, "packages"."is_registered" AS t0_r8, "packages"."readme" AS t0_r9, "packages"."readme_type" AS t0_r10, "counters"."id" AS t1_r0, "counters"."fork" AS t1_r1, "counters"."stargazer" AS t1_r2, "counters"."open_issue" AS t1_r3, "counters"."package_id" AS t1_r4, "counters"."created_at" AS t1_r5, "counters"."updated_at" AS t1_r6, "counters"."contributor" AS t1_r7 FROM "packages" LEFT OUTER JOIN "counters" ON "counters"."package_id" = "packages"."id" WHERE "packages"."owner_id" = $1 AND "packages"."owner_type" = $2 ORDER BY counters.stargazer desc][0m [["owner_id", 12720761], ["owner_type", "User"]]]

D, [2023-10-02T07:07:56.827037 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][36mRelease Load (315.3ms)][0m ][1m][34mSELECT "releases".* FROM "releases" ORDER BY "releases"."published_at" ASC][0m]

D, [2023-10-02T07:07:59.573047 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35m (6.7ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:07:59.575139 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35mSQL (0.5ms)][0m ][1m][32mINSERT INTO "ahoy_events" ("visit_id", "name", "properties", "time") VALUES ($1, $2, $3, $4) RETURNING "id"][0m [["visit_id", 16414241], ["name", "Viewed: users#show"], ["properties", "{}"], ["time", 2023-10-02 07:07:59 UTC]]]

D, [2023-10-02T07:07:59.576543 #19776 DEBUG -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] ][1m][35m (0.9ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:07:59.576976 #19776] INFO -- : [84c89ebb-f2ef-48fc-9709-56e470b31a0c] {:_method=>"GET", :_path=>"/users/fredrik-johansson", :_format=>:html, :_controller=>"UsersController", :_action=>"show", :_status=>200, :_duration=>3141.09, :_view=>2776.01, :_db=>345.94, :_time=>2023-10-02 07:07:56 +0000, :short_message=>"[200] GET /users/fredrik-johansson (UsersController#show)"}

D, [2023-10-02T07:08:34.073380 #19776 DEBUG -- : [b727f266-6577-4cb7-b49a-f269023a77e1] ][1m][35m (0.2ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:08:34.077661 #19776 DEBUG -- : [b727f266-6577-4cb7-b49a-f269023a77e1] ][1m][35mSQL (2.3ms)][0m ][1m][32mINSERT INTO "visits" ("visit_token", "visitor_token", "ip", "user_agent", "landing_page", "browser", "os", "device_type", "started_at") VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9) RETURNING "id"][0m [["visit_token", "b9c1d9ef-1bf4-452f-be6c-bb8526b65693"], ["visitor_token", "325108f7-79c9-4beb-9294-f24f68f6b7d8"], ["ip", "64.252.67.9"], ["user_agent", "Amazon CloudFront"], ["landing_page", "http://cdn.juliaobserver.com/logs"], ["browser", "Other"], ["os", "Other"], ["device_type", "Desktop"], ["started_at", 2023-10-02 07:08:34 UTC]]]

D, [2023-10-02T07:08:34.079176 #19776 DEBUG -- : [b727f266-6577-4cb7-b49a-f269023a77e1] ][1m][35m (0.8ms)][0m ][1m][35mCOMMIT][0m]

D, [2023-10-02T07:08:34.081013 #19776 DEBUG -- : [b727f266-6577-4cb7-b49a-f269023a77e1] [ActiveJob] ][1m][35m (0.1ms)][0m ][1m][35mBEGIN][0m]

D, [2023-10-02T07:08:34.083091 #19776 DEBUG -- : [b727f266-6577-4cb7-b49a-f269023a77e1] [ActiveJob] ][1m][35mSQL (0.5ms)][0m ][1m][32mINSERT INTO "delayed_jobs" ("handler", "run_at", "queue", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5) RETURNING "id"][0m [["handler", "--- !ruby/object:ActiveJob::QueueAdapters::DelayedJobAdapter::JobWrapper\njob_data:\n job_class: Ahoy::GeocodeJob\n job_id: ce6820ae-78f6-4f25-b751-2dbfc494552d\n queue_name: ahoy\n priority: \n arguments:\n - _aj_globalid: gid://julia-observer/Visit/16414242\n locale: en\n"], ["run_at", 2023-10-02 07:08:34 UTC], ["queue", "ahoy"], ["created_at", 2023-10-02 07:08:34 UTC], ["updated_at", 2023-10-02 07:08:34 UTC]]]

D, [2023-10-02T07:08:34.084372 #19776 DEBUG -- : [b727f266-6577-4cb7-b49a-f269023a77e1] [ActiveJob] ][1m][35m (0.8ms)][0m ][1m][35mCOMMIT][0m]

I, [2023-10-02T07:08:34.084805 #19776] INFO -- : [b727f266-6577-4cb7-b49a-f269023a77e1] [ActiveJob] Enqueued Ahoy::GeocodeJob (Job ID: ce6820ae-78f6-4f25-b751-2dbfc494552d) to DelayedJob(ahoy) with arguments: #<GlobalID:0x00007f510dd5cce8 @uri=#<URI::GID gid://julia-observer/Visit/16414242>>