2025-10-27T10:05:41.772712321Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-10-27T10:05:41.773191626Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-10-27T10:05:41.818674973Z [mod-init] Running Docker Modification Logic
2025-10-27T10:05:42.081171776Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-10-27T10:05:42.760537277Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-10-27T10:05:43.115110088Z [mod-init] Installing linuxserver/mods:universal-redis
2025-10-27T10:05:43.141201300Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-10-27T10:05:43.142314201Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-10-27T10:05:43.163614627Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-10-27T10:05:43.167062850Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-10-27T10:05:43.167220517Z s6-rc: info: service fix-attrs: starting
2025-10-27T10:05:43.167437244Z s6-rc: info: service init-migrations: starting
2025-10-27T10:05:43.167605162Z s6-rc: info: service init-envfile: starting
2025-10-27T10:05:43.173948734Z [migrations] started
2025-10-27T10:05:43.174089067Z [migrations] no migrations found
2025-10-27T10:05:43.174377417Z s6-rc: info: service fix-attrs successfully started
2025-10-27T10:05:43.174551708Z s6-rc: info: service legacy-cont-init: starting
2025-10-27T10:05:43.174663082Z s6-rc: info: service init-migrations successfully started
2025-10-27T10:05:43.174770068Z s6-rc: info: service init-adduser: starting
2025-10-27T10:05:43.175667755Z s6-rc: info: service init-envfile successfully started
2025-10-27T10:05:43.181245184Z s6-rc: info: service legacy-cont-init successfully started
2025-10-27T10:05:43.205261720Z usermod: no changes
2025-10-27T10:05:43.212966763Z ───────────────────────────────────────
2025-10-27T10:05:43.213002114Z 
2025-10-27T10:05:43.213013217Z       ██╗     ███████╗██╗ ██████╗
2025-10-27T10:05:43.213024299Z       ██║     ██╔════╝██║██╔═══██╗
2025-10-27T10:05:43.213035161Z       ██║     ███████╗██║██║   ██║
2025-10-27T10:05:43.213046043Z       ██║     ╚════██║██║██║   ██║
2025-10-27T10:05:43.213056804Z       ███████╗███████║██║╚██████╔╝
2025-10-27T10:05:43.213067556Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-10-27T10:05:43.213078869Z 
2025-10-27T10:05:43.213088909Z    Brought to you by linuxserver.io
2025-10-27T10:05:43.213123178Z ───────────────────────────────────────
2025-10-27T10:05:43.213477331Z 
2025-10-27T10:05:43.213490939Z To support LSIO projects visit:
2025-10-27T10:05:43.213499556Z https://www.linuxserver.io/donate/
2025-10-27T10:05:43.213507833Z 
2025-10-27T10:05:43.213515949Z ───────────────────────────────────────
2025-10-27T10:05:43.213524737Z GID/UID
2025-10-27T10:05:43.213532873Z ───────────────────────────────────────
2025-10-27T10:05:43.217825335Z 
2025-10-27T10:05:43.217847901Z User UID:    911
2025-10-27T10:05:43.217856639Z User GID:    911
2025-10-27T10:05:43.217864845Z ───────────────────────────────────────
2025-10-27T10:05:43.220253084Z Linuxserver.io version: v0.127.0-ls111
2025-10-27T10:05:43.220621135Z Build-date: 2025-10-27T09:53:29+00:00
2025-10-27T10:05:43.220645253Z ───────────────────────────────────────
2025-10-27T10:05:43.220657037Z     
2025-10-27T10:05:43.236980272Z s6-rc: info: service init-adduser successfully started
2025-10-27T10:05:43.237157830Z s6-rc: info: service init-device-perms: starting
2025-10-27T10:05:43.242155582Z s6-rc: info: service init-device-perms successfully started
2025-10-27T10:05:43.242297027Z s6-rc: info: service init-os-end: starting
2025-10-27T10:05:43.243415048Z s6-rc: info: service init-os-end successfully started
2025-10-27T10:05:43.243516943Z s6-rc: info: service init-manyfold-config: starting
2025-10-27T10:05:43.243661835Z s6-rc: info: service init-config: starting
2025-10-27T10:05:43.245125762Z s6-rc: info: service init-config successfully started
2025-10-27T10:05:43.245231706Z s6-rc: info: service init-crontab-config: starting
2025-10-27T10:05:43.251106264Z **** SECRET_KEY_BASE set in environment. ****
2025-10-27T10:05:43.256611428Z s6-rc: info: service init-crontab-config successfully started
2025-10-27T10:05:43.276655846Z **** Running Manyfold database init. ****
2025-10-27T10:05:45.604009492Z `/root` is not writable.
2025-10-27T10:05:45.604200106Z Bundler will use `/tmp/bundler20251027-173-eq24bg173' as your home directory temporarily.
2025-10-27T10:05:52.559785268Z Server: 5da6dbbe131e, Context: rails, Role: web, data: {cpu: {one_min: 3.43, five_min: 2.39, fifteen_min: 2.08}, memory: 0.237080576e9, disk: {available: 834827726848, total: 938656133120, used: 103828406272}}
2025-10-27T10:05:52.559837874Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-10-27T10:05:52.559860139Z INFO  2025-10-27T10:05:50.646Z pid=173 tid=2h9: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-27T10:05:52.560022556Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.default_viewer_role` fallback to returns the default value.
2025-10-27T10:05:52.560034149Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-10-27T10:05:52.560043398Z Migrating to CreateLibraries (20210130201037)
2025-10-27T10:05:52.560051544Z == 20210130201037 CreateLibraries: migrating ==================================
2025-10-27T10:05:52.560060743Z -- create_table(:libraries)
2025-10-27T10:05:52.560069089Z    -> 0.0029s
2025-10-27T10:05:52.560077226Z == 20210130201037 CreateLibraries: migrated (0.0029s) =========================
2025-10-27T10:05:52.560085633Z 
2025-10-27T10:05:52.560093819Z Migrating to CreateModels (20210130203243)
2025-10-27T10:05:52.560101976Z == 20210130203243 CreateModels: migrating =====================================
2025-10-27T10:05:52.560110813Z -- create_table(:models)
2025-10-27T10:05:52.560118800Z    -> 0.0009s
2025-10-27T10:05:52.560127186Z == 20210130203243 CreateModels: migrated (0.0009s) ============================
2025-10-27T10:05:52.560135373Z 
2025-10-27T10:05:52.560143459Z Migrating to CreateParts (20210205230918)
2025-10-27T10:05:52.560151315Z == 20210205230918 CreateParts: migrating ======================================
2025-10-27T10:05:52.560159542Z -- create_table(:parts)
2025-10-27T10:05:52.560167748Z    -> 0.0035s
2025-10-27T10:05:52.560176055Z == 20210205230918 CreateParts: migrated (0.0036s) =============================
2025-10-27T10:05:52.560184843Z 
2025-10-27T10:05:52.560192889Z Migrating to AddFieldsToParts (20210210153744)
2025-10-27T10:05:52.560200965Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-10-27T10:05:52.560208891Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-10-27T10:05:52.560217188Z    -> 0.0007s
2025-10-27T10:05:52.560225905Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-10-27T10:05:52.560234462Z    -> 0.0003s
2025-10-27T10:05:52.560242950Z == 20210210153744 AddFieldsToParts: migrated (0.0011s) ========================
2025-10-27T10:05:52.560251377Z 
2025-10-27T10:05:52.560259373Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-10-27T10:05:52.560267880Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-10-27T10:05:52.560277539Z -- create_table(:tags, {id: :integer})
2025-10-27T10:05:52.560287068Z    -> 0.0040s
2025-10-27T10:05:52.560296417Z -- create_table(:taggings, {id: :integer})
2025-10-27T10:05:52.560315596Z    -> 0.0020s
2025-10-27T10:05:52.560323822Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-27T10:05:52.560332119Z    -> 0.0002s
2025-10-27T10:05:52.560340015Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-27T10:05:52.560348422Z    -> 0.0021s
2025-10-27T10:05:52.560356248Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0084s) ===============
2025-10-27T10:05:52.560364304Z 
2025-10-27T10:05:52.560372049Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-10-27T10:05:52.560380005Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-10-27T10:05:52.560388072Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-10-27T10:05:52.560396248Z    -> 0.0003s
2025-10-27T10:05:52.560404074Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-27T10:05:52.560412220Z    -> 0.0004s
2025-10-27T10:05:52.560420146Z -- remove_foreign_key(:taggings, :tags)
2025-10-27T10:05:52.560428243Z    -> 0.1819s
2025-10-27T10:05:52.560436068Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-27T10:05:52.560444185Z    -> 0.0167s
2025-10-27T10:05:52.560452041Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-10-27T10:05:52.560460207Z    -> 0.0002s
2025-10-27T10:05:52.560468143Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-10-27T10:05:52.560476580Z    -> 0.0052s
2025-10-27T10:05:52.560484466Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-10-27T10:05:52.560492582Z    -> 0.0715s
2025-10-27T10:05:52.560500438Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3105s) =================
2025-10-27T10:05:52.560508514Z 
2025-10-27T10:05:52.560516330Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-10-27T10:05:52.560524356Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-10-27T10:05:52.560532603Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-10-27T10:05:52.560540619Z    -> 0.0344s
2025-10-27T10:05:52.560548495Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1116s) ===========
2025-10-27T10:05:52.560556531Z 
2025-10-27T10:05:52.560564407Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-10-27T10:05:52.560572643Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-10-27T10:05:52.560581181Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-27T10:05:52.560598886Z    -> 0.0003s
2025-10-27T10:05:52.560606742Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-10-27T10:05:52.560615069Z 
2025-10-27T10:05:52.560623065Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-10-27T10:05:52.560631311Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-10-27T10:05:52.560639688Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0008s) ==============
2025-10-27T10:05:52.560648055Z 
2025-10-27T10:05:52.560656462Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-10-27T10:05:52.560664468Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-10-27T10:05:52.560672775Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-27T10:05:52.560680871Z    -> 0.0086s
2025-10-27T10:05:52.560688998Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-27T10:05:52.560697104Z    -> 0.0002s
2025-10-27T10:05:52.560705821Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-27T10:05:52.560713998Z    -> 0.0058s
2025-10-27T10:05:52.560722104Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-27T10:05:52.560730531Z    -> 0.0012s
2025-10-27T10:05:52.560738678Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-27T10:05:52.560746964Z    -> 0.0004s
2025-10-27T10:05:52.560754880Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-27T10:05:52.560763047Z    -> 0.0001s
2025-10-27T10:05:52.560770862Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-27T10:05:52.560779259Z    -> 0.0039s
2025-10-27T10:05:52.560787436Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-27T10:05:52.560796153Z    -> 0.0002s
2025-10-27T10:05:52.560804019Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-27T10:05:52.560812125Z    -> 0.0005s
2025-10-27T10:05:52.560820492Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-27T10:05:52.560829100Z    -> 0.0001s
2025-10-27T10:05:52.560837276Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-27T10:05:52.560845623Z    -> 0.0005s
2025-10-27T10:05:52.560854280Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-27T10:05:52.560862808Z    -> 0.0001s
2025-10-27T10:05:52.560879992Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-27T10:05:52.560888319Z    -> 0.0015s
2025-10-27T10:05:52.560896185Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-27T10:05:52.560904542Z    -> 0.0002s
2025-10-27T10:05:52.560912468Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0240s) =============
2025-10-27T10:05:52.560922177Z 
2025-10-27T10:05:52.560930293Z Migrating to AddPreviewPartToModel (20210220204055)
2025-10-27T10:05:52.560939823Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-10-27T10:05:52.560948480Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-10-27T10:05:52.560957077Z    -> 0.2419s
2025-10-27T10:05:52.560966136Z == 20210220204055 AddPreviewPartToModel: migrated (0.2420s) ===================
2025-10-27T10:05:52.560975013Z 
2025-10-27T10:05:52.560982799Z Migrating to CreateCreators (20210225232756)
2025-10-27T10:05:52.560990745Z == 20210225232756 CreateCreators: migrating ===================================
2025-10-27T10:05:52.560999823Z -- create_table(:creators)
2025-10-27T10:05:52.561007799Z    -> 0.0135s
2025-10-27T10:05:52.561016046Z == 20210225232756 CreateCreators: migrated (0.0135s) ==========================
2025-10-27T10:05:52.561024012Z 
2025-10-27T10:05:52.561031848Z Migrating to AddCreatorToModels (20210225232841)
2025-10-27T10:05:52.561039774Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-10-27T10:05:52.561047970Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-10-27T10:05:52.561056508Z    -> 0.0511s
2025-10-27T10:05:52.561064794Z == 20210225232841 AddCreatorToModels: migrated (0.0512s) ======================
2025-10-27T10:05:52.561072870Z 
2025-10-27T10:05:52.561080606Z Migrating to CreateLinks (20210301230017)
2025-10-27T10:05:52.561088472Z == 20210301230017 CreateLinks: migrating ======================================
2025-10-27T10:05:52.561096498Z -- create_table(:links)
2025-10-27T10:05:52.561104314Z    -> 0.0008s
2025-10-27T10:05:52.561112200Z == 20210301230017 CreateLinks: migrated (0.0008s) =============================
2025-10-27T10:05:52.561120236Z 
2025-10-27T10:05:52.561128102Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-10-27T10:05:52.561136058Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-10-27T10:05:52.561144014Z -- remove_column(:creators, :thingiverse_user, :string)
2025-10-27T10:05:52.561152000Z    -> 0.0627s
2025-10-27T10:05:52.561160146Z -- remove_column(:creators, :cults3d_user, :string)
2025-10-27T10:05:52.561177651Z    -> 0.0039s
2025-10-27T10:05:52.561186008Z -- remove_column(:creators, :mmf_user, :string)
2025-10-27T10:05:52.561193914Z    -> 0.0133s
2025-10-27T10:05:52.561202101Z -- remove_column(:creators, :cgtrader_user, :string)
2025-10-27T10:05:52.561210067Z    -> 0.0035s
2025-10-27T10:05:52.561217912Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0854s) ==============
2025-10-27T10:05:52.561226179Z 
2025-10-27T10:05:52.561234336Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-10-27T10:05:52.561242282Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-10-27T10:05:52.561250929Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-10-27T10:05:52.561258925Z    -> 0.0537s
2025-10-27T10:05:52.561267172Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0537s) ==
2025-10-27T10:05:52.561275158Z 
2025-10-27T10:05:52.561283134Z Migrating to AddYUpToParts (20210318202638)
2025-10-27T10:05:52.561291030Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-10-27T10:05:52.561299537Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-10-27T10:05:52.561307834Z    -> 0.0145s
2025-10-27T10:05:52.561316140Z == 20210318202638 AddYUpToParts: migrated (0.0146s) ===========================
2025-10-27T10:05:52.561324848Z 
2025-10-27T10:05:52.561332904Z Migrating to CreateImages (20210321164508)
2025-10-27T10:05:52.561340800Z == 20210321164508 CreateImages: migrating =====================================
2025-10-27T10:05:52.561348876Z -- create_table(:images)
2025-10-27T10:05:52.561356672Z    -> 0.0154s
2025-10-27T10:05:52.561364768Z == 20210321164508 CreateImages: migrated (0.0155s) ============================
2025-10-27T10:05:52.561372834Z 
2025-10-27T10:05:52.561381973Z Migrating to CreateDelayedJobs (20210330215825)
2025-10-27T10:05:53.271519050Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-10-27T10:05:53.271569120Z -- create_table(:delayed_jobs)
2025-10-27T10:05:53.271579782Z    -> 0.0087s
2025-10-27T10:05:53.271590513Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-10-27T10:05:53.271601025Z    -> 0.0002s
2025-10-27T10:05:53.271611436Z == 20210330215825 CreateDelayedJobs: migrated (0.0089s) =======================
2025-10-27T10:05:53.271622197Z 
2025-10-27T10:05:53.271631967Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-10-27T10:05:53.271641847Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-10-27T10:05:53.271682288Z -- rename_table(:parts, :model_files)
2025-10-27T10:05:53.271692198Z    -> 0.0017s
2025-10-27T10:05:53.271700134Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-10-27T10:05:53.271708250Z    -> 0.0330s
2025-10-27T10:05:53.271716217Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0347s) =================
2025-10-27T10:05:53.271724283Z 
2025-10-27T10:05:53.271732038Z Migrating to RemoveImagesTable (20220106220519)
2025-10-27T10:05:53.271740586Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-10-27T10:05:53.271748983Z -- drop_table(:images)
2025-10-27T10:05:53.271759424Z    -> 0.0004s
2025-10-27T10:05:53.271769384Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-10-27T10:05:53.271779464Z 
2025-10-27T10:05:53.271787610Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-10-27T10:05:53.271795817Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-10-27T10:05:53.271803843Z -- table_exists?(:active_storage_blobs)
2025-10-27T10:05:53.271811779Z    -> 0.0001s
2025-10-27T10:05:53.271819595Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-10-27T10:05:53.271827731Z 
2025-10-27T10:05:53.271835557Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-10-27T10:05:53.271843493Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-10-27T10:05:53.271871489Z -- table_exists?(:active_storage_blobs)
2025-10-27T10:05:53.271879455Z    -> 0.0001s
2025-10-27T10:05:53.271887321Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-10-27T10:05:53.271895668Z 
2025-10-27T10:05:53.271903403Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-10-27T10:05:53.271911440Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-10-27T10:05:53.271919486Z -- table_exists?(:active_storage_blobs)
2025-10-27T10:05:53.271929105Z    -> 0.0001s
2025-10-27T10:05:53.271938775Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-10-27T10:05:53.271948604Z 
2025-10-27T10:05:53.271958254Z Migrating to DeviseCreateUsers (20220614210023)
2025-10-27T10:05:53.271969637Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-10-27T10:05:53.271981340Z -- create_table(:users)
2025-10-27T10:05:53.271993094Z    -> 0.0011s
2025-10-27T10:05:53.272005118Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-10-27T10:05:53.272017062Z    -> 0.0015s
2025-10-27T10:05:53.272042594Z == 20220614210023 DeviseCreateUsers: migrated (0.0027s) =======================
2025-10-27T10:05:53.272052944Z 
2025-10-27T10:05:53.272062193Z Migrating to AddUsernameToUsers (20220614211256)
2025-10-27T10:05:53.272074328Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-10-27T10:05:53.272084688Z -- add_column(:users, :username, :string, {null: false})
2025-10-27T10:05:53.272094578Z    -> 0.0212s
2025-10-27T10:05:53.272104809Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-10-27T10:05:53.272115510Z    -> 0.0001s
2025-10-27T10:05:53.272125831Z == 20220614211256 AddUsernameToUsers: migrated (0.0214s) ======================
2025-10-27T10:05:53.272135891Z 
2025-10-27T10:05:53.272144589Z Migrating to AddAdminToUsers (20220614213902)
2025-10-27T10:05:53.272154058Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-10-27T10:05:53.272163427Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-27T10:05:53.272173828Z    -> 0.0005s
2025-10-27T10:05:53.272184169Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-10-27T10:05:53.272194950Z 
2025-10-27T10:05:53.272205151Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-10-27T10:05:53.272215321Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-10-27T10:05:53.272225752Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-10-27T10:05:53.272238518Z    -> 0.0011s
2025-10-27T10:05:53.272248568Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0011s) =============
2025-10-27T10:05:53.272258438Z 
2025-10-27T10:05:53.272268038Z Migrating to CreateSettings (20220619174307)
2025-10-27T10:05:53.272278178Z == 20220619174307 CreateSettings: migrating ===================================
2025-10-27T10:05:53.272288509Z -- create_table(:settings)
2025-10-27T10:05:53.272298409Z    -> 0.0027s
2025-10-27T10:05:53.272308439Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-10-27T10:05:53.272317227Z    -> 0.0002s
2025-10-27T10:05:53.272325062Z == 20220619174307 CreateSettings: migrated (0.0030s) ==========================
2025-10-27T10:05:53.272333830Z 
2025-10-27T10:05:53.272343540Z Migrating to AddScaleFactorToModels (20220626152444)
2025-10-27T10:05:53.272353419Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-10-27T10:05:53.272363299Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-10-27T10:05:53.272373209Z    -> 0.0099s
2025-10-27T10:05:53.272398380Z == 20220626152444 AddScaleFactorToModels: migrated (0.0122s) ==================
2025-10-27T10:05:53.272409001Z 
2025-10-27T10:05:53.272418230Z Migrating to AddDigestToModelFiles (20220702202932)
2025-10-27T10:05:53.272426206Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-10-27T10:05:53.272434202Z -- add_column(:model_files, :digest, :string)
2025-10-27T10:05:53.272442168Z    -> 0.0025s
2025-10-27T10:05:53.272449984Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-10-27T10:05:53.272458110Z    -> 0.0002s
2025-10-27T10:05:53.272466016Z == 20220702202932 AddDigestToModelFiles: migrated (0.0046s) ===================
2025-10-27T10:05:53.272474463Z 
2025-10-27T10:05:53.272483221Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-10-27T10:05:53.272491177Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-10-27T10:05:53.272499273Z -- add_column(:users, :renderer_settings, :json, {default: {"grid_width" => 200, "grid_depth" => 200, "show_grid" => true, "enable_pan_zoom" => false, "background_colour" => "#000000", "object_colour" => "#ffffff", "render_style" => "original"}})
2025-10-27T10:05:53.272511187Z    -> 0.0009s
2025-10-27T10:05:53.272519053Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0012s) ==============
2025-10-27T10:05:53.272527089Z 
2025-10-27T10:05:53.272534825Z Migrating to CreateProblems (20221210001132)
2025-10-27T10:05:53.272542821Z == 20221210001132 CreateProblems: migrating ===================================
2025-10-27T10:05:53.272550857Z -- create_table(:problems)
2025-10-27T10:05:53.272558743Z    -> 0.0008s
2025-10-27T10:05:53.272566569Z == 20221210001132 CreateProblems: migrated (0.0020s) ==========================
2025-10-27T10:05:53.272574605Z 
2025-10-27T10:05:53.272582280Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-10-27T10:05:53.272590316Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-10-27T10:05:53.272598292Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0178s) ========
2025-10-27T10:05:53.272606379Z 
2025-10-27T10:05:53.272614074Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-10-27T10:05:53.272622020Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-10-27T10:05:53.272630036Z -- create_table(:favorites, {force: true})
2025-10-27T10:05:53.272640026Z    -> 0.0046s
2025-10-27T10:05:53.272649626Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-10-27T10:05:53.272660037Z    -> 0.0002s
2025-10-27T10:05:53.272670287Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-10-27T10:05:53.272693113Z    -> 0.0002s
2025-10-27T10:05:53.272703043Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-10-27T10:05:53.272716070Z    -> 0.0002s
2025-10-27T10:05:53.272729106Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0057s) ================
2025-10-27T10:05:53.272741841Z 
2025-10-27T10:05:53.272755038Z Migrating to MovePrintedToFavorites (20221220223040)
2025-10-27T10:05:53.272765429Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-10-27T10:05:53.272775950Z == 20221220223040 MovePrintedToFavorites: migrated (0.0633s) ==================
2025-10-27T10:05:53.272786572Z 
2025-10-27T10:05:53.272796311Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-10-27T10:05:53.272806923Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-10-27T10:05:53.272816873Z -- remove_column(:model_files, :printed, :boolean)
2025-10-27T10:05:53.272826793Z    -> 0.0247s
2025-10-27T10:05:53.272838757Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0251s) ===============
2025-10-27T10:05:53.272848747Z 
2025-10-27T10:05:53.272857514Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-10-27T10:05:53.272867084Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-10-27T10:05:53.272876152Z -- add_column(:models, :notes, :text)
2025-10-27T10:05:53.272885691Z    -> 0.0011s
2025-10-27T10:05:53.272895431Z -- add_column(:models, :excerpt, :text)
2025-10-27T10:05:53.272905411Z    -> 0.0022s
2025-10-27T10:05:53.272915381Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0034s) =================
2025-10-27T10:05:53.272926012Z 
2025-10-27T10:05:53.272936453Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-10-27T10:05:53.272947325Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-10-27T10:05:53.272958448Z -- add_column(:creators, :notes, :text)
2025-10-27T10:05:53.272968327Z    -> 0.0005s
2025-10-27T10:05:53.272978538Z -- add_column(:creators, :excerpt, :text)
2025-10-27T10:05:53.272988448Z    -> 0.0005s
2025-10-27T10:05:53.272996735Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-10-27T10:05:53.273005001Z 
2025-10-27T10:05:53.273012817Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-10-27T10:05:53.273021444Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-10-27T10:05:53.273029601Z -- add_column(:model_files, :notes, :text)
2025-10-27T10:05:53.273049902Z    -> 0.0005s
2025-10-27T10:05:53.273057808Z -- add_column(:model_files, :excerpt, :text)
2025-10-27T10:05:53.273065794Z    -> 0.0007s
2025-10-27T10:05:53.273073680Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0013s) =============
2025-10-27T10:05:53.273081676Z 
2025-10-27T10:05:53.273089331Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-10-27T10:05:53.273097898Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-10-27T10:05:53.273106165Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0189s) =================
2025-10-27T10:05:53.273114141Z 
2025-10-27T10:05:53.273122037Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-10-27T10:05:53.273130474Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-10-27T10:05:53.273138470Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-10-27T10:05:53.273146727Z    -> 0.0403s
2025-10-27T10:05:53.273154562Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0403s) =============
2025-10-27T10:05:53.273162889Z 
2025-10-27T10:05:53.273170555Z Migrating to RenameExcerptToCaption (20230222155910)
2025-10-27T10:05:53.273178420Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-10-27T10:05:53.273186427Z -- rename_column(:creators, :excerpt, :caption)
2025-10-27T10:05:53.273194312Z    -> 0.0207s
2025-10-27T10:05:53.273202208Z -- rename_column(:models, :excerpt, :caption)
2025-10-27T10:05:53.273210104Z    -> 0.0201s
2025-10-27T10:05:53.273218351Z -- rename_column(:model_files, :excerpt, :caption)
2025-10-27T10:05:53.273226658Z    -> 0.0185s
2025-10-27T10:05:53.273235125Z == 20230222155910 RenameExcerptToCaption: migrated (0.0616s) ==================
2025-10-27T10:05:53.273243311Z 
2025-10-27T10:05:53.273250987Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-10-27T10:05:53.724372900Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-10-27T10:05:53.724413602Z -- add_column(:libraries, :notes, :string)
2025-10-27T10:05:53.724423933Z    -> 0.0019s
2025-10-27T10:05:53.724432831Z -- add_column(:libraries, :caption, :string)
2025-10-27T10:05:53.724440987Z    -> 0.0005s
2025-10-27T10:05:53.724449063Z -- add_column(:libraries, :name, :string)
2025-10-27T10:05:53.724457039Z    -> 0.0005s
2025-10-27T10:05:53.724464995Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0108s) ============
2025-10-27T10:05:53.724473152Z 
2025-10-27T10:05:53.724481028Z Migrating to AddTagregexToLibrary (20230305180823)
2025-10-27T10:05:53.724503563Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-10-27T10:05:53.724511860Z -- add_column(:libraries, :tag_regex, :text)
2025-10-27T10:05:53.724519856Z    -> 0.0018s
2025-10-27T10:05:53.724527752Z == 20230305180823 AddTagregexToLibrary: migrated (0.0033s) ====================
2025-10-27T10:05:53.724535758Z 
2025-10-27T10:05:53.724543523Z Migrating to AddIconToLibrary (20230307215826)
2025-10-27T10:05:53.724551459Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-10-27T10:05:53.724559496Z -- add_column(:libraries, :icon, :text)
2025-10-27T10:05:53.724567642Z    -> 0.0017s
2025-10-27T10:05:53.724575648Z == 20230307215826 AddIconToLibrary: migrated (0.0034s) ========================
2025-10-27T10:05:53.724583935Z 
2025-10-27T10:05:53.724592201Z Migrating to CreateCollection (20230308004237)
2025-10-27T10:05:53.724600147Z == 20230308004237 CreateCollection: migrating =================================
2025-10-27T10:05:53.724608214Z -- create_table(:collections)
2025-10-27T10:05:53.724616049Z    -> 0.0026s
2025-10-27T10:05:53.724623885Z == 20230308004237 CreateCollection: migrated (0.0063s) ========================
2025-10-27T10:05:53.724631881Z 
2025-10-27T10:05:53.724639817Z Migrating to AddCollectionToModels (20230308005021)
2025-10-27T10:05:53.724648294Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-10-27T10:05:53.724656511Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-10-27T10:05:53.724664748Z    -> 0.0170s
2025-10-27T10:05:53.724673605Z == 20230308005021 AddCollectionToModels: migrated (0.0203s) ===================
2025-10-27T10:05:53.724682273Z 
2025-10-27T10:05:53.724690539Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-10-27T10:05:53.724698656Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-10-27T10:05:53.724707273Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0016s) =============
2025-10-27T10:05:53.724715329Z 
2025-10-27T10:05:53.724723065Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-10-27T10:05:53.724730981Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-10-27T10:05:53.724739147Z -- rename_column(:collections, :excerpt, :caption)
2025-10-27T10:05:53.724747204Z    -> 0.0041s
2025-10-27T10:05:53.724755661Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0041s) ========
2025-10-27T10:05:53.724764057Z 
2025-10-27T10:05:53.724772374Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-10-27T10:05:53.724780340Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-10-27T10:05:53.724799178Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-10-27T10:05:53.724807996Z 
2025-10-27T10:05:53.724815932Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-10-27T10:05:53.724824128Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-10-27T10:05:53.724832245Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-10-27T10:05:53.724841714Z    -> 0.0015s
2025-10-27T10:05:53.724849740Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0016s) ===============
2025-10-27T10:05:53.724857866Z 
2025-10-27T10:05:53.724865612Z Migrating to AddCollectionToCollections (20230324000000)
2025-10-27T10:05:53.724873538Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-10-27T10:05:53.724881524Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-10-27T10:05:53.724889640Z    -> 0.0060s
2025-10-27T10:05:53.724898518Z == 20230324000000 AddCollectionToCollections: migrated (0.0080s) ==============
2025-10-27T10:05:53.724906514Z 
2025-10-27T10:05:53.724914601Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-10-27T10:05:53.724922847Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-10-27T10:05:53.724930803Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0460s) =========
2025-10-27T10:05:53.724938779Z 
2025-10-27T10:05:53.724946465Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-10-27T10:05:53.724954431Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-10-27T10:05:53.724962417Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0063s) 
2025-10-27T10:05:53.724970473Z 
2025-10-27T10:05:53.724978229Z Migrating to AddSlugs (20230615135601)
2025-10-27T10:05:53.724986074Z == 20230615135601 AddSlugs: migrating =========================================
2025-10-27T10:05:53.724994081Z -- add_column(:models, :slug, :string)
2025-10-27T10:05:53.725001956Z    -> 0.0028s
2025-10-27T10:05:53.725009782Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-10-27T10:05:53.725017979Z    -> 0.0019s
2025-10-27T10:05:53.725025835Z -- add_column(:collections, :slug, :string)
2025-10-27T10:05:53.725033791Z    -> 0.0005s
2025-10-27T10:05:53.725041686Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-10-27T10:05:53.725050073Z    -> 0.0001s
2025-10-27T10:05:53.725057909Z -- add_column(:creators, :slug, :string)
2025-10-27T10:05:53.725074813Z    -> 0.0005s
2025-10-27T10:05:53.725082709Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-10-27T10:05:53.725090785Z    -> 0.0001s
2025-10-27T10:05:53.725098641Z == 20230615135601 AddSlugs: migrated (0.0064s) ================================
2025-10-27T10:05:53.725106707Z 
2025-10-27T10:05:53.725116697Z Migrating to GenerateSlugs (20230617222353)
2025-10-27T10:05:53.725124834Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-10-27T10:05:53.725132830Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-10-27T10:05:53.725140956Z 
2025-10-27T10:05:53.725148972Z Migrating to MakeNamesUnique (20230628194944)
2025-10-27T10:05:53.725157299Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-10-27T10:05:53.725165355Z == 20230628194944 MakeNamesUnique: migrated (0.0030s) =========================
2025-10-27T10:05:53.725173582Z 
2025-10-27T10:05:53.725181869Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-10-27T10:05:53.725189805Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-10-27T10:05:53.725197921Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-10-27T10:05:53.725206117Z    -> 0.0019s
2025-10-27T10:05:53.725213983Z -- remove_index(:creators, :slug)
2025-10-27T10:05:53.725222150Z    -> 0.0004s
2025-10-27T10:05:53.725230336Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-10-27T10:05:53.725238453Z    -> 0.0001s
2025-10-27T10:05:53.725246699Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-10-27T10:05:53.725254866Z    -> 0.0001s
2025-10-27T10:05:53.725262772Z -- remove_index(:collections, :slug)
2025-10-27T10:05:53.725270627Z    -> 0.0227s
2025-10-27T10:05:53.725278553Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-10-27T10:05:53.725286720Z    -> 0.0005s
2025-10-27T10:05:53.725294756Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0263s) ======
2025-10-27T10:05:53.725302932Z 
2025-10-27T10:05:53.725311139Z Migrating to AddSizeToModelFiles (20230707082403)
2025-10-27T10:05:53.725319686Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-10-27T10:05:53.725327702Z -- add_column(:model_files, :size, :integer)
2025-10-27T10:05:53.725336029Z    -> 0.0006s
2025-10-27T10:05:53.725344125Z == 20230707082403 AddSizeToModelFiles: migrated (0.0009s) =====================
2025-10-27T10:05:53.725352552Z 
2025-10-27T10:05:53.725369887Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-10-27T10:05:53.725377873Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-10-27T10:05:53.725386040Z -- change_column(:model_files, :size, :bigint)
2025-10-27T10:05:53.725394016Z    -> 0.0082s
2025-10-27T10:05:53.725402232Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0085s) ==================
2025-10-27T10:05:53.725410699Z 
2025-10-27T10:05:53.725418846Z Migrating to AddNoteToProblems (20230711111009)
2025-10-27T10:05:53.725426922Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-10-27T10:05:53.725435209Z -- add_column(:problems, :note, :string, {default: nil})
2025-10-27T10:05:53.725443385Z    -> 0.0011s
2025-10-27T10:05:53.725451652Z == 20230711111009 AddNoteToProblems: migrated (0.0020s) =======================
2025-10-27T10:05:53.725459728Z 
2025-10-27T10:05:53.725467484Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-10-27T10:05:53.725475410Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-10-27T10:05:53.725484508Z -- add_column(:users, :problem_settings, :json, {default: {"missing" => :danger, "empty" => :info, "nesting" => :warning, "inefficient" => :info, "duplicate" => :warning, "no_image" => :silent, "no_3d_model" => :silent, "non_manifold" => :warning, "inside_out" => :warning, "no_license" => :silent, "no_links" => :silent, "no_creator" => :silent, "no_tags" => :silent, "http_error" => :info, "file_naming" => :warning}})
2025-10-27T10:05:53.725499438Z    -> 0.0006s
2025-10-27T10:05:53.725507705Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0006s) ================
2025-10-27T10:05:53.725516072Z 
2025-10-27T10:05:53.725524529Z Migrating to AddLicenseToModel (20240127143358)
2025-10-27T10:05:53.725533336Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-10-27T10:05:53.725541783Z -- add_column(:models, :license, :string)
2025-10-27T10:05:53.725549990Z    -> 0.0005s
2025-10-27T10:05:53.725557856Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-10-27T10:05:53.725566132Z 
2025-10-27T10:05:53.725574509Z Migrating to AddIgnoredToProblems (20240131134832)
2025-10-27T10:05:53.725582986Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-10-27T10:05:53.725591924Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-10-27T10:05:53.725599970Z    -> 0.0006s
2025-10-27T10:05:53.725607816Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-10-27T10:05:53.725615782Z 
2025-10-27T10:05:53.725623458Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-10-27T10:05:53.725642827Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-10-27T10:05:53.725651504Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-10-27T10:05:53.725659951Z    -> 0.0091s
2025-10-27T10:05:53.725667987Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0091s) ======
2025-10-27T10:05:53.725676344Z 
2025-10-27T10:05:53.725684010Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-10-27T10:05:53.725691926Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-10-27T10:05:53.725699922Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-10-27T10:05:53.725708289Z    -> 0.0007s
2025-10-27T10:05:53.725716114Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0008s) ===============
2025-10-27T10:05:53.725724100Z 
2025-10-27T10:05:53.725731856Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-10-27T10:05:53.725739742Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-10-27T10:05:53.725748019Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-10-27T10:05:53.725756235Z    -> 0.0003s
2025-10-27T10:05:53.725764101Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-10-27T10:05:53.725772317Z    -> 0.0009s
2025-10-27T10:05:53.725780123Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-10-27T10:05:53.725788440Z    -> 0.0001s
2025-10-27T10:05:54.205540057Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-10-27T10:05:54.205584366Z    -> 0.0043s
2025-10-27T10:05:54.205594326Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0058s) =================
2025-10-27T10:05:54.205603013Z 
2025-10-27T10:05:54.205611370Z Migrating to CreateFlipperTables (20240306095646)
2025-10-27T10:05:54.205619827Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-10-27T10:05:54.205628224Z -- create_table(:flipper_features)
2025-10-27T10:05:54.205638735Z    -> 0.0027s
2025-10-27T10:05:54.205646862Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-10-27T10:05:54.205655519Z    -> 0.0045s
2025-10-27T10:05:54.205664808Z -- create_table(:flipper_gates)
2025-10-27T10:05:54.205674738Z    -> 0.0003s
2025-10-27T10:05:54.205685449Z -- add_index(:flipper_gates, [:feature_key, :key, :value], {unique: true, length: {value: 255}, name: "index_flipper_gates_on_feature_key_and_key_and_value"})
2025-10-27T10:05:54.205722795Z    -> 0.0001s
2025-10-27T10:05:54.205731221Z == 20240306095646 CreateFlipperTables: migrated (0.0077s) =====================
2025-10-27T10:05:54.205740450Z 
2025-10-27T10:05:54.205748476Z Migrating to RolifyCreateRoles (20240319155251)
2025-10-27T10:05:54.205756873Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-10-27T10:05:54.205765370Z -- create_table(:roles)
2025-10-27T10:05:54.205774549Z    -> 0.0363s
2025-10-27T10:05:54.205785441Z -- create_table(:users_roles, {id: false})
2025-10-27T10:05:54.205797415Z    -> 0.0006s
2025-10-27T10:05:54.205805711Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-10-27T10:05:54.205814148Z    -> 0.0046s
2025-10-27T10:05:54.205822275Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-10-27T10:05:54.205832245Z    -> 0.0002s
2025-10-27T10:05:54.205842255Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-10-27T10:05:54.205852776Z    -> 0.0001s
2025-10-27T10:05:54.205862456Z == 20240319155251 RolifyCreateRoles: migrated (0.0570s) =======================
2025-10-27T10:05:54.205870772Z 
2025-10-27T10:05:54.205878919Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-10-27T10:05:54.205887326Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-10-27T10:05:54.205895803Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0063s) ==================
2025-10-27T10:05:54.205904180Z 
2025-10-27T10:05:54.205912296Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-10-27T10:05:54.205920663Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-10-27T10:05:54.205928769Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-27T10:05:54.205937126Z    -> 0.0251s
2025-10-27T10:05:54.205945383Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0264s) ====================
2025-10-27T10:05:54.205953790Z 
2025-10-27T10:05:54.205961766Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-10-27T10:05:54.205970583Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-10-27T10:05:54.205979111Z -- add_column(:users, :reset_password_token, :string)
2025-10-27T10:05:54.205987497Z    -> 0.0011s
2025-10-27T10:05:54.205997297Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-10-27T10:05:54.206006115Z    -> 0.0002s
2025-10-27T10:05:54.206014622Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0032s) ============
2025-10-27T10:05:54.206034773Z 
2025-10-27T10:05:54.206042739Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-10-27T10:05:54.206051065Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-10-27T10:05:54.206059432Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0240s) ==============
2025-10-27T10:05:54.206067629Z 
2025-10-27T10:05:54.206075505Z Migrating to AddRememberableToUsers (20240410221112)
2025-10-27T10:05:54.206083841Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-10-27T10:05:54.206092359Z -- add_column(:users, :remember_created_at, :datetime)
2025-10-27T10:05:54.206100755Z    -> 0.0030s
2025-10-27T10:05:54.206109022Z == 20240410221112 AddRememberableToUsers: migrated (0.0042s) ==================
2025-10-27T10:05:54.206117169Z 
2025-10-27T10:05:54.206125014Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-10-27T10:05:54.206133081Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-10-27T10:05:54.206141247Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-10-27T10:05:54.206149373Z    -> 0.0006s
2025-10-27T10:05:54.206157349Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0018s) ===========
2025-10-27T10:05:54.206165576Z 
2025-10-27T10:05:54.206173372Z Migrating to DropDelayedJobs (20240418112821)
2025-10-27T10:05:54.206181368Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-10-27T10:05:54.206189524Z -- drop_table(:delayed_jobs)
2025-10-27T10:05:54.206198081Z    -> 0.0017s
2025-10-27T10:05:54.206206308Z == 20240418112821 DropDelayedJobs: migrated (0.0108s) =========================
2025-10-27T10:05:54.206214685Z 
2025-10-27T10:05:54.206222761Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-10-27T10:05:54.206231409Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-10-27T10:05:54.206239505Z -- add_column(:users, :interface_language, :string)
2025-10-27T10:05:54.206247792Z    -> 0.0007s
2025-10-27T10:05:54.206256259Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0038s) =============
2025-10-27T10:05:54.206264856Z 
2025-10-27T10:05:54.206272942Z Migrating to AddLockableToUsers (20240610120318)
2025-10-27T10:05:54.206281299Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-10-27T10:05:54.206289756Z -- change_table(:users)
2025-10-27T10:05:54.206298063Z    -> 0.0016s
2025-10-27T10:05:54.206306369Z == 20240610120318 AddLockableToUsers: migrated (0.0019s) ======================
2025-10-27T10:05:54.206314776Z 
2025-10-27T10:05:54.206332542Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-10-27T10:05:54.206341119Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-10-27T10:05:54.206349256Z -- add_column(:model_files, :attachment_data, :json)
2025-10-27T10:05:54.206360278Z    -> 0.0006s
2025-10-27T10:05:54.206370879Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0009s) ===========
2025-10-27T10:05:54.206381391Z 
2025-10-27T10:05:54.206391391Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-10-27T10:05:54.206401401Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-10-27T10:05:54.206410689Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0194s) ==================
2025-10-27T10:05:54.206418966Z 
2025-10-27T10:05:54.206428906Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-10-27T10:05:54.206436982Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-10-27T10:05:54.206445079Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-10-27T10:05:54.206454919Z    -> 0.0007s
2025-10-27T10:05:54.206464969Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0024s) ============
2025-10-27T10:05:54.206474929Z 
2025-10-27T10:05:54.206483817Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-10-27T10:05:54.206491833Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-10-27T10:05:54.206499899Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-10-27T10:05:54.206508025Z    -> 0.0006s
2025-10-27T10:05:54.206515951Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-10-27T10:05:54.206524128Z    -> 0.0006s
2025-10-27T10:05:54.206532054Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-10-27T10:05:54.206540110Z    -> 0.0008s
2025-10-27T10:05:54.206548076Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-10-27T10:05:54.206556192Z    -> 0.0045s
2025-10-27T10:05:54.206564389Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-10-27T10:05:54.206572485Z    -> 0.0006s
2025-10-27T10:05:54.206582175Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0082s) ====================
2025-10-27T10:05:54.206592516Z 
2025-10-27T10:05:54.206602345Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-10-27T10:05:54.206611474Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-10-27T10:05:54.206619630Z -- remove_index(:libraries, :path)
2025-10-27T10:05:54.206627586Z    -> 0.0012s
2025-10-27T10:05:54.206635522Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0018s) ================
2025-10-27T10:05:54.206654410Z 
2025-10-27T10:05:54.206662256Z Migrating to CreateFederailsActors (20240727113215)
2025-10-27T10:05:54.206672817Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-10-27T10:05:54.206682637Z -- create_table(:federails_actors)
2025-10-27T10:05:54.206693018Z    -> 0.0009s
2025-10-27T10:05:54.206701114Z -- foreign_key_exists?(:federails_actors, :users)
2025-10-27T10:05:54.206709391Z    -> 0.0015s
2025-10-27T10:05:54.206717567Z -- remove_foreign_key(:federails_actors, :users)
2025-10-27T10:05:54.206726084Z    -> 0.0117s
2025-10-27T10:05:54.206734010Z -- remove_index(:federails_actors, :user_id)
2025-10-27T10:05:54.206743700Z    -> 0.0004s
2025-10-27T10:05:54.206754141Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-10-27T10:05:54.206763971Z    -> 0.0001s
2025-10-27T10:05:54.206772237Z -- add_foreign_key(:federails_actors, :users)
2025-10-27T10:05:54.206780213Z    -> 0.0099s
2025-10-27T10:05:54.206788410Z == 20240727113215 CreateFederailsActors: migrated (0.0253s) ===================
2025-10-27T10:05:54.206796526Z 
2025-10-27T10:05:54.206806546Z Migrating to CreateFederailsFollowings (20240727113216)
2025-10-27T10:05:54.206816837Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-10-27T10:05:54.206827078Z -- create_table(:federails_followings)
2025-10-27T10:05:54.206837419Z    -> 0.0013s
2025-10-27T10:05:54.206847198Z == 20240727113216 CreateFederailsFollowings: migrated (0.0013s) ===============
2025-10-27T10:05:54.206856677Z 
2025-10-27T10:05:54.206864754Z Migrating to CreateFederailsActivities (20240727113217)
2025-10-27T10:05:54.206874092Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-10-27T10:05:54.206884143Z -- create_table(:federails_activities)
2025-10-27T10:05:54.206894303Z    -> 0.0083s
2025-10-27T10:05:54.206903101Z == 20240727113217 CreateFederailsActivities: migrated (0.0083s) ===============
2025-10-27T10:05:54.206911247Z 
2025-10-27T10:05:54.206919003Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-10-27T10:05:54.206927039Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-10-27T10:05:54.206935105Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-10-27T10:05:54.206943332Z    -> 0.0085s
2025-10-27T10:05:54.206951278Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-10-27T10:05:54.206959364Z    -> 0.0004s
2025-10-27T10:05:54.206978443Z -- change_table(:federails_actors)
2025-10-27T10:05:54.206986469Z    -> 0.0064s
2025-10-27T10:05:54.206994375Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0154s) =======
2025-10-27T10:05:54.207002401Z 
2025-10-27T10:05:54.207010126Z Migrating to CreateFederailsActors (20240731165647)
2025-10-27T10:05:54.207018082Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-10-27T10:05:54.207026089Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-10-27T10:05:54.207034165Z 
2025-10-27T10:05:54.207041920Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-10-27T10:05:54.207049947Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-10-27T10:05:54.207057943Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-10-27T10:05:54.207066059Z 
2025-10-27T10:05:54.207073795Z Migrating to BackfillActivities (20240805111500)
2025-10-27T10:05:54.207081741Z == 20240805111500 BackfillActivities: migrating ===============================
2025-10-27T10:05:54.207089787Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-10-27T10:05:54.207099566Z 
2025-10-27T10:05:54.207107362Z Migrating to CreateCaberRelations (20240827155630)
2025-10-27T10:05:54.207115378Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-10-27T10:05:54.207123465Z -- create_table(:caber_relations)
2025-10-27T10:05:54.207131411Z    -> 0.0361s
2025-10-27T10:05:54.207139316Z == 20240827155630 CreateCaberRelations: migrated (0.0361s) ====================
2025-10-27T10:05:54.207147423Z 
2025-10-27T10:05:54.207155208Z Migrating to AddDefaultAccessControls (20240830121749)
2025-10-27T10:05:54.207165108Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-10-27T10:05:54.873839607Z == 20240830121749 AddDefaultAccessControls: migrated (0.0537s) ================
2025-10-27T10:05:54.873891321Z 
2025-10-27T10:05:54.873900740Z Migrating to RenameDefaultRoles (20240830151650)
2025-10-27T10:05:54.873909207Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-10-27T10:05:54.873917634Z == 20240830151650 RenameDefaultRoles: migrated (0.0428s) ======================
2025-10-27T10:05:54.873926131Z 
2025-10-27T10:05:54.873934799Z Migrating to AddPublicIDsToModels (20240904151944)
2025-10-27T10:05:54.873942935Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-10-27T10:05:54.873951292Z -- add_column(:models, :public_id, :string)
2025-10-27T10:05:54.873959439Z    -> 0.0008s
2025-10-27T10:05:54.873967876Z -- add_index(:models, :public_id)
2025-10-27T10:05:54.874004970Z    -> 0.0025s
2025-10-27T10:05:54.874013327Z -- add_column(:model_files, :public_id, :string)
2025-10-27T10:05:54.874021353Z    -> 0.0007s
2025-10-27T10:05:54.874029510Z -- add_index(:model_files, :public_id)
2025-10-27T10:05:54.874037516Z    -> 0.0002s
2025-10-27T10:05:54.874045452Z -- add_column(:problems, :public_id, :string)
2025-10-27T10:05:54.874053718Z    -> 0.0007s
2025-10-27T10:05:54.874062236Z -- add_index(:problems, :public_id)
2025-10-27T10:05:54.874070101Z    -> 0.0001s
2025-10-27T10:05:54.874078198Z -- add_column(:creators, :public_id, :string)
2025-10-27T10:05:54.874086995Z    -> 0.0006s
2025-10-27T10:05:54.874095392Z -- add_index(:creators, :public_id)
2025-10-27T10:05:54.874103278Z    -> 0.0002s
2025-10-27T10:05:54.874111134Z -- add_column(:collections, :public_id, :string)
2025-10-27T10:05:54.874119320Z    -> 0.0006s
2025-10-27T10:05:54.874127186Z -- add_index(:collections, :public_id)
2025-10-27T10:05:54.874135102Z    -> 0.0001s
2025-10-27T10:05:54.874142908Z -- add_column(:libraries, :public_id, :string)
2025-10-27T10:05:54.874150834Z    -> 0.0006s
2025-10-27T10:05:54.874158990Z -- add_index(:libraries, :public_id)
2025-10-27T10:05:54.874168389Z    -> 0.0001s
2025-10-27T10:05:54.874176546Z == 20240904151944 AddPublicIDsToModels: migrated (0.0075s) ====================
2025-10-27T10:05:54.874184652Z 
2025-10-27T10:05:54.874192498Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-10-27T10:05:54.874201075Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-10-27T10:05:54.874209111Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:05:54.874217167Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0484s) ==============
2025-10-27T10:05:54.874225544Z 
2025-10-27T10:05:54.874233250Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-10-27T10:05:54.874241236Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-10-27T10:05:54.874249192Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-10-27T10:05:54.874257188Z 
2025-10-27T10:05:54.874264874Z Migrating to DeduplicateRoles (20240923114515)
2025-10-27T10:05:54.874272769Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-10-27T10:05:54.874280715Z == 20240923114515 DeduplicateRoles: migrated (0.1353s) ========================
2025-10-27T10:05:54.874288792Z 
2025-10-27T10:05:54.874296517Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-10-27T10:05:54.874315976Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-10-27T10:05:54.874325315Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-27T10:05:54.874334153Z    -> 0.1522s
2025-10-27T10:05:54.874342279Z -- add_index(:models, :name_lower)
2025-10-27T10:05:54.874350185Z    -> 0.0002s
2025-10-27T10:05:54.874358091Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-27T10:05:54.874366929Z    -> 0.0071s
2025-10-27T10:05:54.874375426Z -- add_index(:creators, :name_lower)
2025-10-27T10:05:54.874383833Z    -> 0.0001s
2025-10-27T10:05:54.874391839Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-27T10:05:54.874400196Z    -> 0.0082s
2025-10-27T10:05:54.874408012Z -- add_index(:collections, :name_lower)
2025-10-27T10:05:54.874416018Z    -> 0.0001s
2025-10-27T10:05:54.874423814Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1681s) =============
2025-10-27T10:05:54.874432060Z 
2025-10-27T10:05:54.874439746Z Migrating to AddKeypairToActors (20240926162407)
2025-10-27T10:05:54.874447642Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-10-27T10:05:54.874455598Z -- change_table(:federails_actors)
2025-10-27T10:05:54.874463604Z    -> 0.0023s
2025-10-27T10:05:54.874471429Z == 20240926162407 AddKeypairToActors: migrated (0.0024s) ======================
2025-10-27T10:05:54.874479566Z 
2025-10-27T10:05:54.874487512Z Migrating to AddUuids (20241004194445)
2025-10-27T10:05:54.874495768Z == 20241004194445 AddUuids: migrating =========================================
2025-10-27T10:05:54.874504165Z -- change_table(:federails_actors)
2025-10-27T10:05:54.874511991Z    -> 0.0037s
2025-10-27T10:05:54.874519817Z -- change_table(:federails_activities)
2025-10-27T10:05:54.874527663Z    -> 0.0010s
2025-10-27T10:05:54.874535478Z -- change_table(:federails_followings)
2025-10-27T10:05:54.874543314Z    -> 0.0010s
2025-10-27T10:05:54.874551491Z == 20241004194445 AddUuids: migrated (0.0057s) ================================
2025-10-27T10:05:54.874559537Z 
2025-10-27T10:05:54.874567433Z Migrating to CreateComments (20241007182824)
2025-10-27T10:05:54.874576411Z == 20241007182824 CreateComments: migrating ===================================
2025-10-27T10:05:54.874585018Z -- create_table(:comments)
2025-10-27T10:05:54.874593826Z    -> 0.0027s
2025-10-27T10:05:54.874602423Z == 20241007182824 CreateComments: migrated (0.0027s) ==========================
2025-10-27T10:05:54.874620149Z 
2025-10-27T10:05:54.874627995Z Migrating to AddSystemToComments (20241009122540)
2025-10-27T10:05:54.874636071Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-10-27T10:05:54.874644308Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-10-27T10:05:54.874652745Z    -> 0.0009s
2025-10-27T10:05:54.874660891Z == 20241009122540 AddSystemToComments: migrated (0.0010s) =====================
2025-10-27T10:05:54.874669208Z 
2025-10-27T10:05:54.874677374Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-10-27T10:05:54.874685450Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-10-27T10:05:54.874693837Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0015s) ============
2025-10-27T10:05:54.874702314Z 
2025-10-27T10:05:54.874710381Z Migrating to AddOmniauthToUsers (20241015090803)
2025-10-27T10:05:54.874718357Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-10-27T10:05:54.874726543Z -- add_column(:users, :auth_provider, :string)
2025-10-27T10:05:54.874735160Z    -> 0.0008s
2025-10-27T10:05:54.874743287Z -- add_column(:users, :auth_uid, :string)
2025-10-27T10:05:54.874751604Z    -> 0.0007s
2025-10-27T10:05:54.874759459Z == 20241015090803 AddOmniauthToUsers: migrated (0.0015s) ======================
2025-10-27T10:05:54.874768007Z 
2025-10-27T10:05:54.874775682Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-10-27T10:05:54.874783638Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-10-27T10:05:54.874791604Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-10-27T10:05:54.874799650Z    -> 0.0008s
2025-10-27T10:05:54.874807506Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-10-27T10:05:54.874815512Z    -> 0.0007s
2025-10-27T10:05:54.874823358Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0016s) =====
2025-10-27T10:05:54.874832036Z 
2025-10-27T10:05:54.874840112Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-10-27T10:05:54.874848218Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-10-27T10:05:54.874856204Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-10-27T10:05:54.874864421Z    -> 0.0010s
2025-10-27T10:05:54.874872337Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0010s) ======
2025-10-27T10:05:54.874880373Z 
2025-10-27T10:05:54.874888038Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-10-27T10:05:54.874896145Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-10-27T10:05:54.874913680Z -- change_table(:users)
2025-10-27T10:05:54.874921696Z    -> 0.0011s
2025-10-27T10:05:54.874929662Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0011s) =====================
2025-10-27T10:05:54.874937798Z 
2025-10-27T10:05:54.874945634Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-10-27T10:05:54.874953530Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-10-27T10:05:54.874961646Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0082s) =================
2025-10-27T10:05:54.874969693Z 
2025-10-27T10:05:54.874977408Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-10-27T10:05:54.874985274Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-10-27T10:05:54.874993270Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-10-27T10:05:54.875001647Z    -> 0.0009s
2025-10-27T10:05:54.875009493Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-10-27T10:05:54.875017790Z    -> 0.0012s
2025-10-27T10:05:54.875025625Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-10-27T10:05:54.875033842Z    -> 0.0004s
2025-10-27T10:05:54.875041758Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-10-27T10:05:54.875049984Z    -> 0.0017s
2025-10-27T10:05:54.875057890Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-10-27T10:05:54.875066137Z    -> 0.0008s
2025-10-27T10:05:54.875074644Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-10-27T10:05:54.875082871Z    -> 0.0008s
2025-10-27T10:05:54.875090726Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-10-27T10:05:54.875098963Z    -> 0.0004s
2025-10-27T10:05:54.875106799Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0064s) ===================
2025-10-27T10:05:54.875114815Z 
2025-10-27T10:05:54.875122550Z Migrating to AddInProgressToProblems (20241105121830)
2025-10-27T10:05:54.875130517Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-10-27T10:05:54.875138513Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-10-27T10:05:54.875146469Z    -> 0.0009s
2025-10-27T10:05:54.875154334Z == 20241105121830 AddInProgressToProblems: migrated (0.0009s) =================
2025-10-27T10:05:54.875162721Z 
2025-10-27T10:05:54.875170417Z Migrating to ClearStuckProblems (20241118155027)
2025-10-27T10:05:54.875187772Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-10-27T10:05:54.875195768Z == 20241118155027 ClearStuckProblems: migrated (0.0191s) ======================
2025-10-27T10:05:54.875204215Z 
2025-10-27T10:05:54.875211920Z Migrating to AddApprovedToUser (20241122121621)
2025-10-27T10:05:54.875220999Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-10-27T10:05:54.875229075Z -- change_table(:users)
2025-10-27T10:05:54.875237993Z    -> 0.0015s
2025-10-27T10:05:54.875245959Z == 20241122121621 AddApprovedToUser: migrated (0.0015s) =======================
2025-10-27T10:05:54.875254065Z 
2025-10-27T10:05:54.875262472Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-10-27T10:05:54.875270769Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-10-27T10:05:54.875278945Z -- create_table(:federails_moderation_reports)
2025-10-27T10:05:54.875287643Z    -> 0.0032s
2025-10-27T10:05:54.875295519Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0033s) ========
2025-10-27T10:05:54.875303825Z 
2025-10-27T10:05:54.875312824Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-10-27T10:05:54.875320870Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-10-27T10:05:54.875329076Z -- create_table(:federails_moderation_domain_blocks)
2025-10-27T10:05:54.875337072Z    -> 0.0005s
2025-10-27T10:05:54.875344938Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-10-27T10:05:54.875353265Z 
2025-10-27T10:05:54.875361912Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-10-27T10:05:54.875370259Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-10-27T10:05:54.875379007Z -- change_column_null(:comments, :commenter_id, true)
2025-10-27T10:05:54.875387574Z    -> 0.0083s
2025-10-27T10:05:54.875395811Z -- change_column_null(:comments, :commenter_type, true)
2025-10-27T10:05:54.875404388Z    -> 0.0079s
2025-10-27T10:05:54.875412805Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-10-27T10:05:54.875421082Z    -> 0.0008s
2025-10-27T10:05:54.875430490Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-10-27T10:05:54.875438877Z    -> 0.0116s
2025-10-27T10:05:55.627896903Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0303s) =======
2025-10-27T10:05:55.627935812Z 
2025-10-27T10:05:55.627944970Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-10-27T10:05:55.627953527Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-10-27T10:05:55.627986744Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-10-27T10:05:55.627997666Z    -> 0.0009s
2025-10-27T10:05:55.628006334Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0009s) =================
2025-10-27T10:05:55.628014500Z 
2025-10-27T10:05:55.628022406Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-10-27T10:05:55.628030462Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-10-27T10:05:55.628038569Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1303s) ==================
2025-10-27T10:05:55.628046785Z 
2025-10-27T10:05:55.628054841Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-10-27T10:05:55.628062647Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-10-27T10:05:55.628070894Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-10-27T10:05:55.628079491Z    -> 0.0019s
2025-10-27T10:05:55.628087237Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0020s) ==========
2025-10-27T10:05:55.628095072Z 
2025-10-27T10:05:55.628102628Z Migrating to AddCreatorToCollections (20250222000000)
2025-10-27T10:05:55.628110433Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-10-27T10:05:55.628118289Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-10-27T10:05:55.628126105Z    -> 0.0228s
2025-10-27T10:05:55.628133850Z == 20250222000000 AddCreatorToCollections: migrated (0.0231s) =================
2025-10-27T10:05:55.628141786Z 
2025-10-27T10:05:55.628149322Z Migrating to AddLocalToActors (20250305171530)
2025-10-27T10:05:55.628157197Z == 20250305171530 AddLocalToActors: migrating =================================
2025-10-27T10:05:55.628165023Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-10-27T10:05:55.628172919Z    -> 0.0009s
2025-10-27T10:05:55.628180585Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-10-27T10:05:55.628188851Z    -> 0.0018s
2025-10-27T10:05:55.628196647Z    -> 0 rows
2025-10-27T10:05:55.628204683Z == 20250305171530 AddLocalToActors: migrated (0.0056s) ========================
2025-10-27T10:05:55.628212559Z 
2025-10-27T10:05:55.628220094Z Migrating to AddActorTypeToActors (20250407160721)
2025-10-27T10:05:55.628228160Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-10-27T10:05:55.628236036Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-10-27T10:05:55.628243952Z    -> 0.0008s
2025-10-27T10:05:55.628251658Z == 20250407160721 AddActorTypeToActors: migrated (0.0008s) ====================
2025-10-27T10:05:55.628269624Z 
2025-10-27T10:05:55.628277279Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-10-27T10:05:55.628286758Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-10-27T10:05:55.628294754Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-10-27T10:05:55.628302670Z    -> 0.0012s
2025-10-27T10:05:55.628310426Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0013s) =================
2025-10-27T10:05:55.628318342Z 
2025-10-27T10:05:55.628325937Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-10-27T10:05:55.628334204Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-10-27T10:05:55.628342100Z -- create_table(:oauth_applications)
2025-10-27T10:05:55.628349905Z    -> 0.0004s
2025-10-27T10:05:55.628357952Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-10-27T10:05:55.628366008Z    -> 0.0002s
2025-10-27T10:05:55.628373743Z -- create_table(:oauth_access_grants)
2025-10-27T10:05:55.628381529Z    -> 0.0008s
2025-10-27T10:05:55.628389475Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-10-27T10:05:55.628398012Z    -> 0.0001s
2025-10-27T10:05:55.628405778Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-10-27T10:05:55.628414055Z    -> 0.0073s
2025-10-27T10:05:55.628421800Z -- create_table(:oauth_access_tokens)
2025-10-27T10:05:55.628429616Z    -> 0.0006s
2025-10-27T10:05:55.628437632Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-10-27T10:05:55.628445839Z    -> 0.0001s
2025-10-27T10:05:55.628453875Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-10-27T10:05:55.628462051Z    -> 0.0001s
2025-10-27T10:05:55.628469807Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-10-27T10:05:55.628477773Z    -> 0.0089s
2025-10-27T10:05:55.628485438Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-10-27T10:05:55.628493334Z    -> 0.0074s
2025-10-27T10:05:55.628501020Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-10-27T10:05:55.628508916Z    -> 0.0108s
2025-10-27T10:05:55.628516611Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0370s) ==================
2025-10-27T10:05:55.628524737Z 
2025-10-27T10:05:55.628532333Z Migrating to AddOwnerToApplication (20250408145956)
2025-10-27T10:05:55.628540128Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-10-27T10:05:55.628557313Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-10-27T10:05:55.628565510Z    -> 0.0011s
2025-10-27T10:05:55.628573846Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-10-27T10:05:55.628581702Z    -> 0.0008s
2025-10-27T10:05:55.628589418Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-10-27T10:05:55.628597304Z    -> 0.0002s
2025-10-27T10:05:55.628605330Z == 20250408145956 AddOwnerToApplication: migrated (0.0071s) ===================
2025-10-27T10:05:55.628614859Z 
2025-10-27T10:05:55.628622484Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-10-27T10:05:55.628630370Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-10-27T10:05:55.628638366Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-10-27T10:05:55.628646893Z    -> 0.0100s
2025-10-27T10:05:55.628654819Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0113s) ============
2025-10-27T10:05:55.628663086Z 
2025-10-27T10:05:55.628671062Z Migrating to AddQuotaToUsers (20250409125753)
2025-10-27T10:05:55.628679128Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-10-27T10:05:55.628688648Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-10-27T10:05:55.628696553Z    -> 0.0010s
2025-10-27T10:05:55.628704289Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-10-27T10:05:55.628712265Z    -> 0.0009s
2025-10-27T10:05:55.628720011Z == 20250409125753 AddQuotaToUsers: migrated (0.0033s) =========================
2025-10-27T10:05:55.628728197Z 
2025-10-27T10:05:55.628735802Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-10-27T10:05:55.628743658Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-10-27T10:05:55.628751624Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-10-27T10:05:55.628760121Z    -> 0.0118s
2025-10-27T10:05:55.628767977Z -- add_index(:model_files, :filename_lower)
2025-10-27T10:05:55.628776074Z    -> 0.0002s
2025-10-27T10:05:55.628783969Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0134s) 
2025-10-27T10:05:55.628792186Z 
2025-10-27T10:05:55.628800042Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-10-27T10:05:55.628807838Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-10-27T10:05:55.628815703Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-10-27T10:05:55.628823820Z    -> 0.0002s
2025-10-27T10:05:55.628840994Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-10-27T10:05:55.628848970Z 
2025-10-27T10:05:55.628856796Z Migrating to AddPreviewToModelFile (20250520111046)
2025-10-27T10:05:55.628864953Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-10-27T10:05:55.628872848Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-10-27T10:05:55.628881265Z    -> 0.0010s
2025-10-27T10:05:55.628889562Z == 20250520111046 AddPreviewToModelFile: migrated (0.0018s) ===================
2025-10-27T10:05:55.628897418Z 
2025-10-27T10:05:55.628904973Z Migrating to CreateAltchaSolutions (20250609210440)
2025-10-27T10:05:55.628912779Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-10-27T10:05:55.628920655Z -- create_table(:altcha_solutions)
2025-10-27T10:05:55.628928821Z    -> 0.0004s
2025-10-27T10:05:55.628936657Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-10-27T10:05:55.628944994Z    -> 0.0002s
2025-10-27T10:05:55.628952709Z == 20250609210440 CreateAltchaSolutions: migrated (0.0016s) ===================
2025-10-27T10:05:55.628960635Z 
2025-10-27T10:05:55.628968210Z Migrating to AddIndexableFields (20250620141805)
2025-10-27T10:05:55.628976036Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-10-27T10:05:55.628983962Z -- change_table(:models)
2025-10-27T10:05:55.628991828Z    -> 0.0025s
2025-10-27T10:05:55.628999564Z -- change_table(:creators)
2025-10-27T10:05:55.629007279Z    -> 0.0017s
2025-10-27T10:05:55.629015145Z -- change_table(:collections)
2025-10-27T10:05:55.629023412Z    -> 0.0017s
2025-10-27T10:05:55.629031678Z == 20250620141805 AddIndexableFields: migrated (0.0060s) ======================
2025-10-27T10:05:55.629039644Z 
2025-10-27T10:05:55.629047560Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-10-27T10:05:55.629055867Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-10-27T10:05:55.629063803Z -- change_column(:models, :indexable, :string)
2025-10-27T10:05:55.629071609Z    -> 0.0365s
2025-10-27T10:05:55.629079344Z -- change_column(:models, :ai_indexable, :string)
2025-10-27T10:05:55.629087430Z    -> 0.0238s
2025-10-27T10:05:55.629095617Z -- change_column(:creators, :indexable, :string)
2025-10-27T10:05:55.629103633Z    -> 0.0100s
2025-10-27T10:05:55.629111359Z -- change_column(:creators, :ai_indexable, :string)
2025-10-27T10:05:55.629119245Z    -> 0.0096s
2025-10-27T10:05:55.629136369Z -- change_column(:collections, :indexable, :string)
2025-10-27T10:05:55.629144906Z    -> 0.0522s
2025-10-27T10:05:55.629152902Z -- change_column(:collections, :ai_indexable, :string)
2025-10-27T10:05:55.629161500Z    -> 0.0142s
2025-10-27T10:05:55.629169836Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1468s) ======
2025-10-27T10:05:55.629177802Z 
2025-10-27T10:05:55.629185428Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-10-27T10:05:55.629193444Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-10-27T10:05:55.629201350Z -- change_table(:models)
2025-10-27T10:05:55.629209045Z    -> 0.0004s
2025-10-27T10:05:55.629216741Z -- change_table(:creators)
2025-10-27T10:05:55.629224426Z    -> 0.0003s
2025-10-27T10:05:55.629232122Z -- change_table(:collections)
2025-10-27T10:05:55.629240068Z    -> 0.0003s
2025-10-27T10:05:55.629248385Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0010s) =================
2025-10-27T10:05:55.629256892Z 
2025-10-27T10:05:55.629264748Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-10-27T10:05:55.629272583Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-10-27T10:05:55.629281010Z -- change_table(:links)
2025-10-27T10:05:55.629288966Z    -> 0.0002s
2025-10-27T10:05:55.629296702Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0009s) =======================
2025-10-27T10:05:55.629304558Z 
2025-10-27T10:05:55.629312454Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-10-27T10:05:55.629322183Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-10-27T10:05:55.629330119Z -- add_column(:links, :synced_at, :datetime)
2025-10-27T10:05:55.629338336Z    -> 0.0011s
2025-10-27T10:05:55.629346292Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0011s) ======================
2025-10-27T10:05:55.629354178Z 
2025-10-27T10:05:55.629362184Z Migrating to CreateFaspClientProviders (20250806142734)
2025-10-27T10:05:55.629370280Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-10-27T10:05:55.629378166Z -- create_table(:fasp_client_providers)
2025-10-27T10:05:55.629386362Z    -> 0.0429s
2025-10-27T10:05:55.629394118Z == 20250806142734 CreateFaspClientProviders: migrated (0.0430s) ===============
2025-10-27T10:05:55.629402044Z 
2025-10-27T10:05:55.629409619Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-10-27T10:05:55.629418217Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-10-27T10:05:55.629426343Z -- create_table(:fasp_client_event_subscriptions)
2025-10-27T10:05:55.629451363Z    -> 0.0138s
2025-10-27T10:05:55.692075571Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0138s) ======
2025-10-27T10:05:55.692122827Z 
2025-10-27T10:05:55.692132536Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-10-27T10:05:55.692140983Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-10-27T10:05:55.692149811Z -- create_table(:fasp_client_backfill_requests)
2025-10-27T10:05:55.692157857Z    -> 0.0065s
2025-10-27T10:05:55.692166324Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0065s) ========
2025-10-27T10:05:55.692174601Z 
2025-10-27T10:05:55.692182958Z Migrating to AddImagesToCreators (20250922155445)
2025-10-27T10:05:55.692191375Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-10-27T10:05:55.692199551Z -- add_column(:creators, :avatar_data, :json)
2025-10-27T10:05:55.692207597Z    -> 0.0010s
2025-10-27T10:05:55.692215433Z -- add_column(:creators, :banner_data, :json)
2025-10-27T10:05:55.692223579Z    -> 0.0009s
2025-10-27T10:05:55.692231616Z == 20250922155445 AddImagesToCreators: migrated (0.0020s) =====================
2025-10-27T10:05:55.692239882Z 
2025-10-27T10:05:55.692248199Z Migrating to CreateFederailsHosts (20251010145758)
2025-10-27T10:05:55.692256416Z == 20251010145758 CreateFederailsHosts: migrating =============================
2025-10-27T10:05:55.692264762Z -- create_table(:federails_hosts)
2025-10-27T10:05:55.692273149Z    -> 0.0191s
2025-10-27T10:05:55.692281035Z == 20251010145758 CreateFederailsHosts: migrated (0.0191s) ====================
2025-10-27T10:05:55.692289172Z 
2025-10-27T10:05:55.886340947Z s6-rc: info: service init-manyfold-config successfully started
2025-10-27T10:05:55.886676653Z s6-rc: info: service init-config-end: starting
2025-10-27T10:05:55.890486243Z s6-rc: info: service init-config-end successfully started
2025-10-27T10:05:55.890719423Z s6-rc: info: service init-mods: starting
2025-10-27T10:05:55.913631855Z s6-rc: info: service init-mods successfully started
2025-10-27T10:05:55.913786026Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-10-27T10:05:55.927159392Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-10-27T10:05:55.927374705Z s6-rc: info: service init-mods-package-install: starting
2025-10-27T10:05:55.938806392Z [pkg-install-init] **** Installing all mod packages ****
2025-10-27T10:05:55.949540053Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-10-27T10:05:56.029665649Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-10-27T10:05:56.368669603Z (1/1) Installing redis (8.0.4-r0)
2025-10-27T10:05:56.404862704Z Executing redis-8.0.4-r0.pre-install
2025-10-27T10:05:56.444767018Z Executing redis-8.0.4-r0.post-install
2025-10-27T10:05:56.452685772Z Executing busybox-1.37.0-r19.trigger
2025-10-27T10:05:56.466489584Z OK: 428 MiB in 119 packages
2025-10-27T10:05:56.556920850Z s6-rc: info: service init-mods-package-install successfully started
2025-10-27T10:05:56.557053437Z s6-rc: info: service init-mods-end: starting
2025-10-27T10:05:56.558313954Z s6-rc: info: service init-mods-end successfully started
2025-10-27T10:05:56.558541132Z s6-rc: info: service init-custom-files: starting
2025-10-27T10:05:56.564137901Z [custom-init] No custom files found, skipping...
2025-10-27T10:05:56.564497054Z s6-rc: info: service init-custom-files successfully started
2025-10-27T10:05:56.564724662Z s6-rc: info: service init-services: starting
2025-10-27T10:05:56.565982054Z s6-rc: info: service init-services successfully started
2025-10-27T10:05:56.566100091Z s6-rc: info: service svc-mod-universal-redis: starting
2025-10-27T10:05:56.566259442Z s6-rc: info: service svc-manyfold: starting
2025-10-27T10:05:56.566660199Z s6-rc: info: service svc-cron: starting
2025-10-27T10:05:56.568267435Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-10-27T10:05:56.568783865Z s6-rc: info: service svc-cron successfully started
2025-10-27T10:05:56.578054039Z 280:C 27 Oct 2025 10:05:56.577 # WARNING Memory overcommit must be enabled! Without it, a background save or replication may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
2025-10-27T10:05:56.578106635Z 280:C 27 Oct 2025 10:05:56.578 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-10-27T10:05:56.578124281Z 280:C 27 Oct 2025 10:05:56.578 * Redis version=8.0.4, bits=64, commit=00000000, modified=1, pid=280, just started
2025-10-27T10:05:56.578131595Z 280:C 27 Oct 2025 10:05:56.578 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-10-27T10:05:56.578765001Z 280:M 27 Oct 2025 10:05:56.578 * monotonic clock: POSIX clock_gettime
2025-10-27T10:05:56.579206990Z 280:M 27 Oct 2025 10:05:56.579 * Running mode=standalone, port=6379.
2025-10-27T10:05:56.579543318Z 280:M 27 Oct 2025 10:05:56.579 * Server initialized
2025-10-27T10:05:56.579571544Z 280:M 27 Oct 2025 10:05:56.579 * Ready to accept connections tcp
2025-10-27T10:05:56.732951992Z 10:05:56 rails.1              | started with pid 301
2025-10-27T10:05:56.732982093Z 10:05:56 default_worker.1     | started with pid 302
2025-10-27T10:05:56.732989097Z 10:05:56 performance_worker.1 | started with pid 303
2025-10-27T10:05:57.983605340Z 10:05:57 rails.1              | `/root` is not writable.
2025-10-27T10:05:57.983652545Z 10:05:57 rails.1              | Bundler will use `/tmp/bundler20251027-301-keoyax301' as your home directory temporarily.
2025-10-27T10:05:58.479096637Z 10:05:58 default_worker.1     | `/root` is not writable.
2025-10-27T10:05:58.479135285Z 10:05:58 performance_worker.1 | `/root` is not writable.
2025-10-27T10:05:58.479145726Z 10:05:58 default_worker.1     | Bundler will use `/tmp/bundler20251027-302-9erq9w302' as your home directory temporarily.
2025-10-27T10:05:58.479216569Z 10:05:58 performance_worker.1 | Bundler will use `/tmp/bundler20251027-303-jeowtv303' as your home directory temporarily.
2025-10-27T10:05:59.485249014Z 10:05:59 rails.1              | => Booting Puma
2025-10-27T10:05:59.485287562Z 10:05:59 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-10-27T10:05:59.485297642Z 10:05:59 rails.1              | => Run `bin/rails server --help` for more startup options
2025-10-27T10:05:59.957452663Z 10:05:59 performance_worker.1 | Server: 5da6dbbe131e, Context: rails, Role: web, data: {cpu: {one_min: 4.51, five_min: 2.65, fifteen_min: 2.17}, memory: 0.194543616e9, disk: {available: 834038784000, total: 938656133120, used: 104617349120}}
2025-10-27T10:05:59.970206302Z 10:05:59 default_worker.1     | Server: 5da6dbbe131e, Context: rails, Role: web, data: {cpu: {one_min: 4.51, five_min: 2.65, fifteen_min: 2.17}, memory: 0.194400256e9, disk: {available: 834038784000, total: 938656133120, used: 104617349120}}
2025-10-27T10:06:02.245724201Z 10:06:02 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:02.246734325Z 10:06:02 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:02.246774275Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.246Z pid=302 tid=232: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-27T10:06:02.247785391Z 10:06:02 performance_worker.1 | INFO  2025-10-27T10:06:02.247Z pid=303 tid=233: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-27T10:06:02.314181755Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.313Z pid=302 tid=232: Booted Rails 8.0.2.1 application in production environment
2025-10-27T10:06:02.314288900Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.313Z pid=302 tid=232: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-27T10:06:02.314372328Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.313Z pid=302 tid=232: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-27T10:06:02.314467400Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.313Z pid=302 tid=232: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-27T10:06:02.316881070Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.316Z pid=302 tid=232: Sidekiq 8.0.8 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-10-27T10:06:02.317974210Z 10:06:02 performance_worker.1 | INFO  2025-10-27T10:06:02.317Z pid=303 tid=233: Booted Rails 8.0.2.1 application in production environment
2025-10-27T10:06:02.318038750Z 10:06:02 performance_worker.1 | INFO  2025-10-27T10:06:02.317Z pid=303 tid=233: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-27T10:06:02.318082508Z 10:06:02 performance_worker.1 | INFO  2025-10-27T10:06:02.317Z pid=303 tid=233: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-27T10:06:02.318187139Z 10:06:02 performance_worker.1 | INFO  2025-10-27T10:06:02.317Z pid=303 tid=233: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-27T10:06:02.320786923Z 10:06:02 performance_worker.1 | INFO  2025-10-27T10:06:02.320Z pid=303 tid=233: Sidekiq 8.0.8 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-10-27T10:06:02.395537287Z 10:06:02 rails.1              | Server: 5da6dbbe131e, Context: rails, Role: web, data: {cpu: {one_min: 4.51, five_min: 2.65, fifteen_min: 2.17}, memory: 0.176590848e9, disk: {available: 834038923264, total: 938656133120, used: 104617209856}}
2025-10-27T10:06:02.395561676Z 10:06:02 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:02.395594341Z 10:06:02 rails.1              | INFO  2025-10-27T10:06:02.236Z pid=301 tid=20t: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-27T10:06:02.395673060Z 10:06:02 rails.1              | INFO  2025-10-27T10:06:02.241Z pid=301 tid=20t: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-27T10:06:02.395720596Z 10:06:02 rails.1              | INFO  2025-10-27T10:06:02.242Z pid=301 tid=20t: Cron Jobs - added job with name clear-downloads in the namespace default
2025-10-27T10:06:02.395792350Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 6495ee2a-2007-491d-a108-cf00e0be09f3) to Sidekiq(high) with arguments: Model(id: integer, name: string, path: string, library_id: integer, created_at: datetime, updated_at: datetime, preview_file_id: integer, creator_id: integer, notes: text, caption: text, collection_id: integer, slug: string, license: string, public_id: string, name_lower: string, sensitive: boolean, indexable: string, ai_indexable: string, tag_list: )
2025-10-27T10:06:02.395833874Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 937ff3bd-5e46-4296-9006-a8e970ca89dd) to Sidekiq(high) with arguments: Creator(id: integer, name: string, created_at: datetime, updated_at: datetime, notes: text, caption: text, slug: string, public_id: string, name_lower: string, indexable: string, ai_indexable: string, avatar_data: json, banner_data: json)
2025-10-27T10:06:02.395991862Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 4291968c-2a0e-453a-b6a5-a69aa8ee0b91) to Sidekiq(high) with arguments: Collection(id: integer, name: string, notes: text, caption: text, created_at: datetime, updated_at: datetime, collection_id: integer, slug: string, public_id: string, name_lower: string, creator_id: integer, indexable: string, ai_indexable: string)
2025-10-27T10:06:02.396017804Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 23f7141c-e156-402a-8788-0559558e4e20) to Sidekiq(upgrade)
2025-10-27T10:06:02.396051492Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 776cc9fe-73ab-4baf-b941-4325e5d3f39a) to Sidekiq(upgrade)
2025-10-27T10:06:02.396062354Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 34a681b7-0a27-451e-8727-50884d5016fa) to Sidekiq(upgrade)
2025-10-27T10:06:02.402280163Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 90aa860d-8b06-4ade-81c6-c3386c67e5b7) to Sidekiq(upgrade)
2025-10-27T10:06:02.402390996Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: be0bc5f7-bbc1-49cf-9012-98b533e92bc3) to Sidekiq(upgrade)
2025-10-27T10:06:02.402448502Z 10:06:02 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: bf16cd71-4d42-4a08-a7ed-41a1f98b22e2) to Sidekiq(upgrade)
2025-10-27T10:06:02.402493693Z 10:06:02 rails.1              | [301] Puma starting in cluster mode...
2025-10-27T10:06:02.402554605Z 10:06:02 rails.1              | [301] * Puma version: 7.1.0 ("Neon Witch")
2025-10-27T10:06:02.402594906Z 10:06:02 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-27T10:06:02.402641270Z 10:06:02 rails.1              | [301] *  Min threads: 4
2025-10-27T10:06:02.402687603Z 10:06:02 rails.1              | [301] *  Max threads: 16
2025-10-27T10:06:02.402728295Z 10:06:02 rails.1              | [301] *  Environment: production
2025-10-27T10:06:02.402772053Z 10:06:02 rails.1              | [301] *   Master PID: 301
2025-10-27T10:06:02.402818036Z 10:06:02 rails.1              | [301] *      Workers: 4
2025-10-27T10:06:02.402875722Z 10:06:02 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-10-27T10:06:02.402922757Z 10:06:02 rails.1              | [301] * Preloading application
2025-10-27T10:06:02.402964270Z 10:06:02 rails.1              | [301] * Listening on http://[::]:3214
2025-10-27T10:06:02.403014100Z 10:06:02 rails.1              | [301] Use Ctrl-C to stop
2025-10-27T10:06:02.428246022Z 10:06:02 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-10-27T10:06:02.428440213Z 10:06:02 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.02s, phase: 0
2025-10-27T10:06:02.428461206Z 10:06:02 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-10-27T10:06:02.429945935Z 10:06:02 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-10-27T10:06:02.571093533Z 10:06:02 default_worker.1     | Server: 5da6dbbe131e, Context: sidekiq, Role: background, data: {cpu: {one_min: 4.71, five_min: 2.72, fifteen_min: 2.19}, memory: 0.234889216e9, disk: {available: 834031001600, total: 938656133120, used: 104625131520}}
2025-10-27T10:06:02.571897101Z 10:06:02 performance_worker.1 | Server: 5da6dbbe131e, Context: sidekiq, Role: background, data: {cpu: {one_min: 4.71, five_min: 2.72, fifteen_min: 2.19}, memory: 0.235360256e9, disk: {available: 834031001600, total: 938656133120, used: 104625131520}}
2025-10-27T10:06:02.602289664Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-10-27T10:06:02.604221714Z s6-rc: info: service svc-manyfold successfully started
2025-10-27T10:06:02.604448541Z s6-rc: info: service legacy-services: starting
2025-10-27T10:06:02.614914032Z s6-rc: info: service legacy-services successfully started
2025-10-27T10:06:02.615091148Z s6-rc: info: service ci-service-check: starting
2025-10-27T10:06:02.619372348Z [ls.io-init] done.
2025-10-27T10:06:02.620231969Z s6-rc: info: service ci-service-check successfully started
2025-10-27T10:06:02.633289609Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.571Z pid=302 tid=hoe jid=30d92daefcbe87073877aeda class=Upgrade::GenerateSlugsJob: start
2025-10-27T10:06:02.641608689Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [6495ee2a-2007-491d-a108-cf00e0be09f3] Performing Upgrade::GenerateSlugsJob (Job ID: 6495ee2a-2007-491d-a108-cf00e0be09f3) from Sidekiq(high) enqueued at 2025-10-27T10:06:02.256925935Z with arguments: Model(id: integer, name: string, path: string, library_id: integer, created_at: datetime, updated_at: datetime, preview_file_id: integer, creator_id: integer, notes: text, caption: text, collection_id: integer, slug: string, license: string, public_id: string, name_lower: string, sensitive: boolean, indexable: string, ai_indexable: string, tag_list: )
2025-10-27T10:06:02.646155684Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.572Z pid=302 tid=ho6 jid=23cfa0bd382b6ef559674ac0 class=Upgrade::GenerateSlugsJob: start
2025-10-27T10:06:02.659833824Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [937ff3bd-5e46-4296-9006-a8e970ca89dd] Performing Upgrade::GenerateSlugsJob (Job ID: 937ff3bd-5e46-4296-9006-a8e970ca89dd) from Sidekiq(high) enqueued at 2025-10-27T10:06:02.259961457Z with arguments: Creator(id: integer, name: string, created_at: datetime, updated_at: datetime, notes: text, caption: text, slug: string, public_id: string, name_lower: string, indexable: string, ai_indexable: string, avatar_data: json, banner_data: json)
2025-10-27T10:06:02.662424369Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.633Z pid=302 tid=hn2 jid=37c5ee73f190cd3ca313f9f6 class=Upgrade::GenerateSlugsJob: start
2025-10-27T10:06:02.723298915Z 10:06:02 default_worker.1     | INFO  2025-10-27T10:06:02.641Z pid=302 tid=hq6 jid=9f53aca10c9c11b5e0a4fcd7 class=Upgrade::FixNilFileSizeValues: start
2025-10-27T10:06:02.726764452Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4291968c-2a0e-453a-b6a5-a69aa8ee0b91] Performing Upgrade::GenerateSlugsJob (Job ID: 4291968c-2a0e-453a-b6a5-a69aa8ee0b91) from Sidekiq(high) enqueued at 2025-10-27T10:06:02.261765108Z with arguments: Collection(id: integer, name: string, notes: text, caption: text, created_at: datetime, updated_at: datetime, collection_id: integer, slug: string, public_id: string, name_lower: string, creator_id: integer, indexable: string, ai_indexable: string)
2025-10-27T10:06:02.727833254Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [23f7141c-e156-402a-8788-0559558e4e20] Performing Upgrade::FixNilFileSizeValues (Job ID: 23f7141c-e156-402a-8788-0559558e4e20) from Sidekiq(upgrade) enqueued at 2025-10-27T10:06:02.263472566Z
2025-10-27T10:06:02.732522075Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [937ff3bd-5e46-4296-9006-a8e970ca89dd] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:02.738640393Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [937ff3bd-5e46-4296-9006-a8e970ca89dd] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-27T10:06:02.770092179Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [937ff3bd-5e46-4296-9006-a8e970ca89dd] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.035
2025-10-27T10:06:02.780777303Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [23f7141c-e156-402a-8788-0559558e4e20] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:02.799884193Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4291968c-2a0e-453a-b6a5-a69aa8ee0b91] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:02.996063071Z 10:06:02 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [23f7141c-e156-402a-8788-0559558e4e20] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-27T10:06:03.014905118Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [23f7141c-e156-402a-8788-0559558e4e20] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.185
2025-10-27T10:06:03.041017453Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4291968c-2a0e-453a-b6a5-a69aa8ee0b91] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-27T10:06:03.051141256Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4291968c-2a0e-453a-b6a5-a69aa8ee0b91] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.021
2025-10-27T10:06:03.052735546Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [6495ee2a-2007-491d-a108-cf00e0be09f3] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:03.136278532Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [6495ee2a-2007-491d-a108-cf00e0be09f3] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-27T10:06:03.136307601Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [6495ee2a-2007-491d-a108-cf00e0be09f3] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.070
2025-10-27T10:06:03.149029335Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [937ff3bd-5e46-4296-9006-a8e970ca89dd] Performed Upgrade::GenerateSlugsJob (Job ID: 937ff3bd-5e46-4296-9006-a8e970ca89dd) from Sidekiq(high) in 500.98ms
2025-10-27T10:06:03.153856213Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [23f7141c-e156-402a-8788-0559558e4e20] Performed Upgrade::FixNilFileSizeValues (Job ID: 23f7141c-e156-402a-8788-0559558e4e20) from Sidekiq(upgrade) in 427.47ms
2025-10-27T10:06:03.154561513Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.153Z pid=302 tid=ho6 jid=23cfa0bd382b6ef559674ac0 class=Upgrade::GenerateSlugsJob elapsed=0.582: done
2025-10-27T10:06:03.155110308Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.154Z pid=302 tid=hq6 jid=9f53aca10c9c11b5e0a4fcd7 class=Upgrade::FixNilFileSizeValues elapsed=0.513: done
2025-10-27T10:06:03.155588441Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4291968c-2a0e-453a-b6a5-a69aa8ee0b91] Performed Upgrade::GenerateSlugsJob (Job ID: 4291968c-2a0e-453a-b6a5-a69aa8ee0b91) from Sidekiq(high) in 472.17ms
2025-10-27T10:06:03.155889006Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.155Z pid=302 tid=ho6 jid=f59c1c80dd63017b6ba008ed class=Upgrade::BackfillDataPackages: start
2025-10-27T10:06:03.157031457Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [6495ee2a-2007-491d-a108-cf00e0be09f3] Performed Upgrade::GenerateSlugsJob (Job ID: 6495ee2a-2007-491d-a108-cf00e0be09f3) from Sidekiq(high) in 519.86ms
2025-10-27T10:06:03.157425029Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.155Z pid=302 tid=hq6 jid=35f3ea138ea61c57b5412d15 class=Upgrade::DisambiguateUsernamesJob: start
2025-10-27T10:06:03.163932280Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.163Z pid=302 tid=hoe jid=30d92daefcbe87073877aeda class=Upgrade::GenerateSlugsJob elapsed=0.592: done
2025-10-27T10:06:03.163999456Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [776cc9fe-73ab-4baf-b941-4325e5d3f39a] Performing Upgrade::BackfillDataPackages (Job ID: 776cc9fe-73ab-4baf-b941-4325e5d3f39a) from Sidekiq(upgrade) enqueued at 2025-10-27T10:06:02.264151653Z
2025-10-27T10:06:03.164600255Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.156Z pid=302 tid=hn2 jid=37c5ee73f190cd3ca313f9f6 class=Upgrade::GenerateSlugsJob elapsed=0.524: done
2025-10-27T10:06:03.165573986Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [34a681b7-0a27-451e-8727-50884d5016fa] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 34a681b7-0a27-451e-8727-50884d5016fa) from Sidekiq(upgrade) enqueued at 2025-10-27T10:06:02.264790550Z
2025-10-27T10:06:03.166177972Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.164Z pid=302 tid=hoe jid=d03d567c0c369ff38636d7eb class=Upgrade::UpdateActorsJob: start
2025-10-27T10:06:03.169797129Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [776cc9fe-73ab-4baf-b941-4325e5d3f39a] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:03.220916964Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.165Z pid=302 tid=hn2 jid=94c472a2cf39f5f2764ca604 class=Upgrade::FixParentCollections: start
2025-10-27T10:06:03.295165056Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [90aa860d-8b06-4ade-81c6-c3386c67e5b7] Performing Upgrade::UpdateActorsJob (Job ID: 90aa860d-8b06-4ade-81c6-c3386c67e5b7) from Sidekiq(upgrade) enqueued at 2025-10-27T10:06:02.265671393Z
2025-10-27T10:06:03.299870380Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [34a681b7-0a27-451e-8727-50884d5016fa] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:03.430297563Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [be0bc5f7-bbc1-49cf-9012-98b533e92bc3] Performing Upgrade::FixParentCollections (Job ID: be0bc5f7-bbc1-49cf-9012-98b533e92bc3) from Sidekiq(upgrade) enqueued at 2025-10-27T10:06:02.266286922Z
2025-10-27T10:06:03.465465711Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [90aa860d-8b06-4ade-81c6-c3386c67e5b7] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:03.551075899Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [be0bc5f7-bbc1-49cf-9012-98b533e92bc3] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:03.558031554Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [776cc9fe-73ab-4baf-b941-4325e5d3f39a] Performed Upgrade::BackfillDataPackages (Job ID: 776cc9fe-73ab-4baf-b941-4325e5d3f39a) from Sidekiq(upgrade) in 401.12ms
2025-10-27T10:06:03.592358849Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.592Z pid=302 tid=ho6 jid=f59c1c80dd63017b6ba008ed class=Upgrade::BackfillDataPackages elapsed=0.436: done
2025-10-27T10:06:03.592742732Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [34a681b7-0a27-451e-8727-50884d5016fa] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 34a681b7-0a27-451e-8727-50884d5016fa) from Sidekiq(upgrade) in 434.65ms
2025-10-27T10:06:03.596439314Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.595Z pid=302 tid=ho6 jid=c5eb85ee89cae2092b000917 class=Upgrade::PruneOrphanedProblems: start
2025-10-27T10:06:03.607579264Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [90aa860d-8b06-4ade-81c6-c3386c67e5b7] Performed Upgrade::UpdateActorsJob (Job ID: 90aa860d-8b06-4ade-81c6-c3386c67e5b7) from Sidekiq(upgrade) in 426.42ms
2025-10-27T10:06:03.607606809Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.596Z pid=302 tid=hq6 jid=35f3ea138ea61c57b5412d15 class=Upgrade::DisambiguateUsernamesJob elapsed=0.441: done
2025-10-27T10:06:03.607620727Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf16cd71-4d42-4a08-a7ed-41a1f98b22e2] Performing Upgrade::PruneOrphanedProblems (Job ID: bf16cd71-4d42-4a08-a7ed-41a1f98b22e2) from Sidekiq(upgrade) enqueued at 2025-10-27T10:06:02.266930268Z
2025-10-27T10:06:03.610158447Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.609Z pid=302 tid=hoe jid=d03d567c0c369ff38636d7eb class=Upgrade::UpdateActorsJob elapsed=0.445: done
2025-10-27T10:06:03.610535286Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [be0bc5f7-bbc1-49cf-9012-98b533e92bc3] Performed Upgrade::FixParentCollections (Job ID: be0bc5f7-bbc1-49cf-9012-98b533e92bc3) from Sidekiq(upgrade) in 312.38ms
2025-10-27T10:06:03.610808896Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.610Z pid=302 tid=hn2 jid=94c472a2cf39f5f2764ca604 class=Upgrade::FixParentCollections elapsed=0.445: done
2025-10-27T10:06:03.611691584Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf16cd71-4d42-4a08-a7ed-41a1f98b22e2] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-27T10:06:03.786626980Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf16cd71-4d42-4a08-a7ed-41a1f98b22e2] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-27T10:06:03.792223508Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf16cd71-4d42-4a08-a7ed-41a1f98b22e2] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.169
2025-10-27T10:06:03.813835392Z 10:06:03 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf16cd71-4d42-4a08-a7ed-41a1f98b22e2] Performed Upgrade::PruneOrphanedProblems (Job ID: bf16cd71-4d42-4a08-a7ed-41a1f98b22e2) from Sidekiq(upgrade) in 214.93ms
2025-10-27T10:06:03.815197935Z 10:06:03 default_worker.1     | INFO  2025-10-27T10:06:03.814Z pid=302 tid=ho6 jid=c5eb85ee89cae2092b000917 class=Upgrade::PruneOrphanedProblems elapsed=0.218: done
2025-10-27T10:06:33.011355989Z 10:06:33 rails.1              | [3aa78a7d-9edd-4822-bc36-15ffd8c50b96] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1390,"duration":32.23,"view":0.0,"db":4.32,"@timestamp":"2025-10-27T10:06:33.009Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-27T10:06:33.983624224Z 10:06:33 rails.1              | [4d950cd5-d25a-45d7-8da5-340777a65eab] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":92876,"duration":949.39,"view":0.0,"db":23.04,"location":"http://172.17.0.5:3214/","@timestamp":"2025-10-27T10:06:33.983Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-27T10:06:34.080250272Z 10:06:34 rails.1              | [c1f89705-a86b-45aa-9702-9743b8deeda8] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1092,"duration":60.59,"view":0.0,"db":3.81,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-10-27T10:06:34.056Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-27T10:06:34.720539236Z 10:06:34 rails.1              | [a2d5a6fd-f6b6-47c0-a72c-f8fc04a712a8] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24957,"duration":601.87,"view":420.68,"db":78.55,"@timestamp":"2025-10-27T10:06:34.719Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-10-27T10:06:34.795155890Z 10:06:34 rails.1              | [0f419783-b7ba-4ee8-b431-c2e909dd43df] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1178,"duration":33.47,"view":0.0,"db":4.53,"@timestamp":"2025-10-27T10:06:34.793Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-27T10:06:35.045855771Z 10:06:35 rails.1              | [15497faa-7103-43c6-bad5-06f8e15bc15e] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14470,"duration":161.48,"view":0.0,"db":2.07,"location":"http://172.17.0.5:3214/","@timestamp":"2025-10-27T10:06:35.020Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-27T10:06:35.089656650Z 10:06:35 rails.1              | [82e5412e-8865-49ab-8216-8b17b620ee4c] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1102,"duration":33.61,"view":0.0,"db":3.14,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-10-27T10:06:35.089Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-27T10:06:35.537154417Z 10:06:35 rails.1              | [a363aa5f-e706-4cbb-b95a-41ba86298d33] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":25177,"duration":419.9,"view":235.68,"db":1.47,"@timestamp":"2025-10-27T10:06:35.531Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}