2025-10-10T15:31:36.245309619Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-10-10T15:31:36.245360642Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-10-10T15:31:36.296120818Z [mod-init] Running Docker Modification Logic
2025-10-10T15:31:36.532218081Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-10-10T15:31:37.223442593Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-10-10T15:31:37.679165953Z [mod-init] Installing linuxserver/mods:universal-redis
2025-10-10T15:31:37.703434738Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-10-10T15:31:37.704486165Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-10-10T15:31:37.727984680Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-10-10T15:31:37.756546970Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-10-10T15:31:37.756808446Z s6-rc: info: service fix-attrs: starting
2025-10-10T15:31:37.757151928Z s6-rc: info: service init-migrations: starting
2025-10-10T15:31:37.762244822Z s6-rc: info: service init-envfile: starting
2025-10-10T15:31:37.764819256Z [migrations] started
2025-10-10T15:31:37.764904969Z [migrations] no migrations found
2025-10-10T15:31:37.765839591Z s6-rc: info: service fix-attrs successfully started
2025-10-10T15:31:37.765956967Z s6-rc: info: service legacy-cont-init: starting
2025-10-10T15:31:37.768058428Z s6-rc: info: service init-migrations successfully started
2025-10-10T15:31:37.768181255Z s6-rc: info: service init-adduser: starting
2025-10-10T15:31:37.781004505Z s6-rc: info: service init-envfile successfully started
2025-10-10T15:31:37.785195333Z s6-rc: info: service legacy-cont-init successfully started
2025-10-10T15:31:37.835624763Z usermod: no changes
2025-10-10T15:31:37.841739245Z ───────────────────────────────────────
2025-10-10T15:31:37.841771189Z 
2025-10-10T15:31:37.841780327Z       ██╗     ███████╗██╗ ██████╗
2025-10-10T15:31:37.841790528Z       ██║     ██╔════╝██║██╔═══██╗
2025-10-10T15:31:37.841801440Z       ██║     ███████╗██║██║   ██║
2025-10-10T15:31:37.841812302Z       ██║     ╚════██║██║██║   ██║
2025-10-10T15:31:37.841823444Z       ███████╗███████║██║╚██████╔╝
2025-10-10T15:31:37.841834366Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-10-10T15:31:37.841845479Z 
2025-10-10T15:31:37.841855829Z    Brought to you by linuxserver.io
2025-10-10T15:31:37.841909347Z ───────────────────────────────────────
2025-10-10T15:31:37.842214692Z 
2025-10-10T15:31:37.842234131Z To support LSIO projects visit:
2025-10-10T15:31:37.842238229Z https://www.linuxserver.io/donate/
2025-10-10T15:31:37.842241967Z 
2025-10-10T15:31:37.842245654Z ───────────────────────────────────────
2025-10-10T15:31:37.842250424Z GID/UID
2025-10-10T15:31:37.842253991Z ───────────────────────────────────────
2025-10-10T15:31:37.846233223Z 
2025-10-10T15:31:37.846243654Z User UID:    911
2025-10-10T15:31:37.846247462Z User GID:    911
2025-10-10T15:31:37.846251620Z ───────────────────────────────────────
2025-10-10T15:31:37.847737703Z Linuxserver.io version: v0.125.0-ls107
2025-10-10T15:31:37.848016584Z Build-date: 2025-10-10T15:20:06+00:00
2025-10-10T15:31:37.848024360Z ───────────────────────────────────────
2025-10-10T15:31:37.848028408Z     
2025-10-10T15:31:37.865054731Z s6-rc: info: service init-adduser successfully started
2025-10-10T15:31:37.865325546Z s6-rc: info: service init-device-perms: starting
2025-10-10T15:31:37.870318950Z s6-rc: info: service init-device-perms successfully started
2025-10-10T15:31:37.870445886Z s6-rc: info: service init-os-end: starting
2025-10-10T15:31:37.871485269Z s6-rc: info: service init-os-end successfully started
2025-10-10T15:31:37.871644670Z s6-rc: info: service init-manyfold-config: starting
2025-10-10T15:31:37.871792618Z s6-rc: info: service init-config: starting
2025-10-10T15:31:37.873473041Z s6-rc: info: service init-config successfully started
2025-10-10T15:31:37.873760149Z s6-rc: info: service init-crontab-config: starting
2025-10-10T15:31:37.875893074Z **** SECRET_KEY_BASE set in environment. ****
2025-10-10T15:31:37.883431052Z s6-rc: info: service init-crontab-config successfully started
2025-10-10T15:31:37.895399610Z **** Running Manyfold database init. ****
2025-10-10T15:31:40.195921758Z `/root` is not writable.
2025-10-10T15:31:40.196284548Z Bundler will use `/tmp/bundler20251010-173-ne2zdg173' as your home directory temporarily.
2025-10-10T15:31:47.511700750Z Server: f46409e1f5ea, Context: rails, Role: web, data: {cpu: {one_min: 5.03, five_min: 3.81, fifteen_min: 2.69}, memory: 0.21399552e9, disk: {available: 835209154560, total: 938656133120, used: 103446978560}}
2025-10-10T15:31:47.511748897Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-10-10T15:31:47.511761523Z INFO  2025-10-10T15:31:45.418Z pid=173 tid=2id: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-10T15:31:47.511805261Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-10-10T15:31:47.511817355Z Migrating to CreateLibraries (20210130201037)
2025-10-10T15:31:47.511827716Z == 20210130201037 CreateLibraries: migrating ==================================
2025-10-10T15:31:47.511838578Z -- create_table(:libraries)
2025-10-10T15:31:47.511867877Z    -> 0.0033s
2025-10-10T15:31:47.511882316Z == 20210130201037 CreateLibraries: migrated (0.0033s) =========================
2025-10-10T15:31:47.511892156Z 
2025-10-10T15:31:47.511900182Z Migrating to CreateModels (20210130203243)
2025-10-10T15:31:47.511908228Z == 20210130203243 CreateModels: migrating =====================================
2025-10-10T15:31:47.511916264Z -- create_table(:models)
2025-10-10T15:31:47.511924160Z    -> 0.0010s
2025-10-10T15:31:47.511932206Z == 20210130203243 CreateModels: migrated (0.0010s) ============================
2025-10-10T15:31:47.511940212Z 
2025-10-10T15:31:47.511947998Z Migrating to CreateParts (20210205230918)
2025-10-10T15:31:47.511956024Z == 20210205230918 CreateParts: migrating ======================================
2025-10-10T15:31:47.511964141Z -- create_table(:parts)
2025-10-10T15:31:47.511971996Z    -> 0.0043s
2025-10-10T15:31:47.511979912Z == 20210205230918 CreateParts: migrated (0.0043s) =============================
2025-10-10T15:31:47.511987898Z 
2025-10-10T15:31:47.511995664Z Migrating to AddFieldsToParts (20210210153744)
2025-10-10T15:31:47.512003610Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-10-10T15:31:47.512011686Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-10-10T15:31:47.512019752Z    -> 0.0008s
2025-10-10T15:31:47.512027608Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-10-10T15:31:47.512035655Z    -> 0.0004s
2025-10-10T15:31:47.512043510Z == 20210210153744 AddFieldsToParts: migrated (0.0013s) ========================
2025-10-10T15:31:47.512051557Z 
2025-10-10T15:31:47.512059523Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-10-10T15:31:47.512067479Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-10-10T15:31:47.512075495Z -- create_table(:tags, {id: :integer})
2025-10-10T15:31:47.512083451Z    -> 0.0047s
2025-10-10T15:31:47.512091437Z -- create_table(:taggings, {id: :integer})
2025-10-10T15:31:47.512099353Z    -> 0.0025s
2025-10-10T15:31:47.512107209Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-10T15:31:47.512127079Z    -> 0.0002s
2025-10-10T15:31:47.512136778Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-10T15:31:47.512145345Z    -> 0.0026s
2025-10-10T15:31:47.512153281Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0101s) ===============
2025-10-10T15:31:47.512161428Z 
2025-10-10T15:31:47.512169434Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-10-10T15:31:47.512177420Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-10-10T15:31:47.512185446Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-10-10T15:31:47.512193593Z    -> 0.0004s
2025-10-10T15:31:47.512201488Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-10T15:31:47.512209665Z    -> 0.0006s
2025-10-10T15:31:47.512217851Z -- remove_foreign_key(:taggings, :tags)
2025-10-10T15:31:47.512226018Z    -> 0.1859s
2025-10-10T15:31:47.512233944Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-10T15:31:47.512242060Z    -> 0.0168s
2025-10-10T15:31:47.512249916Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-10-10T15:31:47.512258102Z    -> 0.0002s
2025-10-10T15:31:47.512265988Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-10-10T15:31:47.512274425Z    -> 0.0057s
2025-10-10T15:31:47.512282281Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-10-10T15:31:47.512290738Z    -> 0.0783s
2025-10-10T15:31:47.512298664Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3255s) =================
2025-10-10T15:31:47.512307422Z 
2025-10-10T15:31:47.512316861Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-10-10T15:31:47.512327382Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-10-10T15:31:47.512337673Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-10-10T15:31:47.512348003Z    -> 0.0381s
2025-10-10T15:31:47.512358354Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1240s) ===========
2025-10-10T15:31:47.512368825Z 
2025-10-10T15:31:47.512379036Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-10-10T15:31:47.512389036Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-10-10T15:31:47.512399487Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-10T15:31:47.512410058Z    -> 0.0003s
2025-10-10T15:31:47.512420039Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0004s) =================
2025-10-10T15:31:47.512443506Z 
2025-10-10T15:31:47.512453506Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-10-10T15:31:47.512464057Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-10-10T15:31:47.512474669Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0008s) ==============
2025-10-10T15:31:47.512485029Z 
2025-10-10T15:31:47.512494869Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-10-10T15:31:47.512505210Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-10-10T15:31:47.512514960Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-10T15:31:47.512523186Z    -> 0.0090s
2025-10-10T15:31:47.512531092Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-10T15:31:47.512539279Z    -> 0.0002s
2025-10-10T15:31:47.512547134Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-10T15:31:47.512555341Z    -> 0.0075s
2025-10-10T15:31:47.512563157Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-10T15:31:47.512571343Z    -> 0.0021s
2025-10-10T15:31:47.512579139Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-10T15:31:47.512587295Z    -> 0.0007s
2025-10-10T15:31:47.512595061Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-10T15:31:47.512603318Z    -> 0.0002s
2025-10-10T15:31:47.512611143Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-10T15:31:47.512619230Z    -> 0.0047s
2025-10-10T15:31:47.512627025Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-10T15:31:47.512635382Z    -> 0.0002s
2025-10-10T15:31:47.512643168Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-10T15:31:47.512651264Z    -> 0.0005s
2025-10-10T15:31:47.512659050Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-10T15:31:47.512667206Z    -> 0.0001s
2025-10-10T15:31:47.512675072Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-10T15:31:47.512683439Z    -> 0.0006s
2025-10-10T15:31:47.512691305Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-10T15:31:47.512699591Z    -> 0.0001s
2025-10-10T15:31:47.512707427Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-10T15:31:47.512715684Z    -> 0.0015s
2025-10-10T15:31:47.512734913Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-10T15:31:47.512743320Z    -> 0.0002s
2025-10-10T15:31:47.512751225Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0282s) =============
2025-10-10T15:31:47.512759342Z 
2025-10-10T15:31:47.512767057Z Migrating to AddPreviewPartToModel (20210220204055)
2025-10-10T15:31:47.512775043Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-10-10T15:31:47.512783280Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-10-10T15:31:47.512791627Z    -> 0.2802s
2025-10-10T15:31:47.512799493Z == 20210220204055 AddPreviewPartToModel: migrated (0.2803s) ===================
2025-10-10T15:31:47.512807699Z 
2025-10-10T15:31:47.512815475Z Migrating to CreateCreators (20210225232756)
2025-10-10T15:31:47.512823421Z == 20210225232756 CreateCreators: migrating ===================================
2025-10-10T15:31:47.512831437Z -- create_table(:creators)
2025-10-10T15:31:47.512839353Z    -> 0.0161s
2025-10-10T15:31:47.512847199Z == 20210225232756 CreateCreators: migrated (0.0162s) ==========================
2025-10-10T15:31:47.512855245Z 
2025-10-10T15:31:47.512863742Z Migrating to AddCreatorToModels (20210225232841)
2025-10-10T15:31:47.512871898Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-10-10T15:31:47.512879935Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-10-10T15:31:47.512887991Z    -> 0.0640s
2025-10-10T15:31:47.512895887Z == 20210225232841 AddCreatorToModels: migrated (0.0641s) ======================
2025-10-10T15:31:47.512904003Z 
2025-10-10T15:31:47.512911739Z Migrating to CreateLinks (20210301230017)
2025-10-10T15:31:47.512919665Z == 20210301230017 CreateLinks: migrating ======================================
2025-10-10T15:31:47.512927721Z -- create_table(:links)
2025-10-10T15:31:47.512935677Z    -> 0.0010s
2025-10-10T15:31:47.512943613Z == 20210301230017 CreateLinks: migrated (0.0010s) =============================
2025-10-10T15:31:47.512951699Z 
2025-10-10T15:31:47.512959435Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-10-10T15:31:47.512967411Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-10-10T15:31:47.512975487Z -- remove_column(:creators, :thingiverse_user, :string)
2025-10-10T15:31:47.512983483Z    -> 0.0769s
2025-10-10T15:31:47.512991409Z -- remove_column(:creators, :cults3d_user, :string)
2025-10-10T15:31:47.512999455Z    -> 0.0044s
2025-10-10T15:31:47.513007331Z -- remove_column(:creators, :mmf_user, :string)
2025-10-10T15:31:47.513024526Z    -> 0.0157s
2025-10-10T15:31:47.513032532Z -- remove_column(:creators, :cgtrader_user, :string)
2025-10-10T15:31:47.513040508Z    -> 0.0042s
2025-10-10T15:31:47.513048324Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.1037s) ==============
2025-10-10T15:31:47.513056400Z 
2025-10-10T15:31:47.513065598Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-10-10T15:31:47.513075809Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-10-10T15:31:47.513087022Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-10-10T15:31:47.513098224Z    -> 0.0586s
2025-10-10T15:31:47.513109527Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0587s) ==
2025-10-10T15:31:47.513120459Z 
2025-10-10T15:31:47.513130329Z Migrating to AddYUpToParts (20210318202638)
2025-10-10T15:31:47.513140339Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-10-10T15:31:47.513150570Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-10-10T15:31:47.513160880Z    -> 0.0162s
2025-10-10T15:31:47.513170991Z == 20210318202638 AddYUpToParts: migrated (0.0162s) ===========================
2025-10-10T15:31:47.513181251Z 
2025-10-10T15:31:47.513190931Z Migrating to CreateImages (20210321164508)
2025-10-10T15:31:47.513200991Z == 20210321164508 CreateImages: migrating =====================================
2025-10-10T15:31:47.513211011Z -- create_table(:images)
2025-10-10T15:31:47.513223056Z    -> 0.0180s
2025-10-10T15:31:47.513232945Z == 20210321164508 CreateImages: migrated (0.0185s) ============================
2025-10-10T15:31:47.513244368Z 
2025-10-10T15:31:47.513254409Z Migrating to CreateDelayedJobs (20210330215825)
2025-10-10T15:31:47.513263878Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-10-10T15:31:47.513272074Z -- create_table(:delayed_jobs)
2025-10-10T15:31:47.513279920Z    -> 0.0100s
2025-10-10T15:31:48.282682124Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-10-10T15:31:48.282720531Z    -> 0.0002s
2025-10-10T15:31:48.282730281Z == 20210330215825 CreateDelayedJobs: migrated (0.0103s) =======================
2025-10-10T15:31:48.282740461Z 
2025-10-10T15:31:48.282748508Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-10-10T15:31:48.282756684Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-10-10T15:31:48.282764911Z -- rename_table(:parts, :model_files)
2025-10-10T15:31:48.282772897Z    -> 0.0017s
2025-10-10T15:31:48.282810132Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-10-10T15:31:48.282818468Z    -> 0.0363s
2025-10-10T15:31:48.282826515Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0380s) =================
2025-10-10T15:31:48.282834581Z 
2025-10-10T15:31:48.282842326Z Migrating to RemoveImagesTable (20220106220519)
2025-10-10T15:31:48.282850232Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-10-10T15:31:48.282858319Z -- drop_table(:images)
2025-10-10T15:31:48.282866195Z    -> 0.0004s
2025-10-10T15:31:48.282874100Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-10-10T15:31:48.282882247Z 
2025-10-10T15:31:48.282890253Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-10-10T15:31:48.282898249Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-10-10T15:31:48.282906275Z -- table_exists?(:active_storage_blobs)
2025-10-10T15:31:48.282914191Z    -> 0.0002s
2025-10-10T15:31:48.282922067Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0002s) ======
2025-10-10T15:31:48.282930244Z 
2025-10-10T15:31:48.282938300Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-10-10T15:31:48.282946316Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-10-10T15:31:48.282954933Z -- table_exists?(:active_storage_blobs)
2025-10-10T15:31:48.282962839Z    -> 0.0001s
2025-10-10T15:31:48.282970665Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-10-10T15:31:48.282978671Z 
2025-10-10T15:31:48.282986336Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-10-10T15:31:48.282994363Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-10-10T15:31:48.283002559Z -- table_exists?(:active_storage_blobs)
2025-10-10T15:31:48.283010475Z    -> 0.0002s
2025-10-10T15:31:48.283018652Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0002s) 
2025-10-10T15:31:48.283026758Z 
2025-10-10T15:31:48.283034634Z Migrating to DeviseCreateUsers (20220614210023)
2025-10-10T15:31:48.283044694Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-10-10T15:31:48.283055185Z -- create_table(:users)
2025-10-10T15:31:48.283065125Z    -> 0.0012s
2025-10-10T15:31:48.283074765Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-10-10T15:31:48.283086228Z    -> 0.0016s
2025-10-10T15:31:48.283097099Z == 20220614210023 DeviseCreateUsers: migrated (0.0028s) =======================
2025-10-10T15:31:48.283107641Z 
2025-10-10T15:31:48.283133062Z Migrating to AddUsernameToUsers (20220614211256)
2025-10-10T15:31:48.283144585Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-10-10T15:31:48.283157391Z -- add_column(:users, :username, :string, {null: false})
2025-10-10T15:31:48.283167742Z    -> 0.0236s
2025-10-10T15:31:48.283177992Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-10-10T15:31:48.283189005Z    -> 0.0002s
2025-10-10T15:31:48.283199856Z == 20220614211256 AddUsernameToUsers: migrated (0.0239s) ======================
2025-10-10T15:31:48.283210007Z 
2025-10-10T15:31:48.283219616Z Migrating to AddAdminToUsers (20220614213902)
2025-10-10T15:31:48.283229656Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-10-10T15:31:48.283239767Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-10T15:31:48.283249927Z    -> 0.0005s
2025-10-10T15:31:48.283258955Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-10-10T15:31:48.283268545Z 
2025-10-10T15:31:48.283277633Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-10-10T15:31:48.283287643Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-10-10T15:31:48.283298054Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-10-10T15:31:48.283310179Z    -> 0.0011s
2025-10-10T15:31:48.283320850Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0011s) =============
2025-10-10T15:31:48.283331582Z 
2025-10-10T15:31:48.283341762Z Migrating to CreateSettings (20220619174307)
2025-10-10T15:31:48.283352283Z == 20220619174307 CreateSettings: migrating ===================================
2025-10-10T15:31:48.283363456Z -- create_table(:settings)
2025-10-10T15:31:48.283373727Z    -> 0.0033s
2025-10-10T15:31:48.283383496Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-10-10T15:31:48.283393947Z    -> 0.0002s
2025-10-10T15:31:48.283403506Z == 20220619174307 CreateSettings: migrated (0.0035s) ==========================
2025-10-10T15:31:48.283411643Z 
2025-10-10T15:31:48.283419419Z Migrating to AddScaleFactorToModels (20220626152444)
2025-10-10T15:31:48.283427866Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-10-10T15:31:48.283436142Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-10-10T15:31:48.283444289Z    -> 0.0107s
2025-10-10T15:31:48.283452225Z == 20220626152444 AddScaleFactorToModels: migrated (0.0132s) ==================
2025-10-10T15:31:48.283472596Z 
2025-10-10T15:31:48.283481293Z Migrating to AddDigestToModelFiles (20220702202932)
2025-10-10T15:31:48.283491544Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-10-10T15:31:48.283501684Z -- add_column(:model_files, :digest, :string)
2025-10-10T15:31:48.283511955Z    -> 0.0034s
2025-10-10T15:31:48.283522145Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-10-10T15:31:48.283532396Z    -> 0.0002s
2025-10-10T15:31:48.283542176Z == 20220702202932 AddDigestToModelFiles: migrated (0.0061s) ===================
2025-10-10T15:31:48.283552787Z 
2025-10-10T15:31:48.283562667Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-10-10T15:31:48.283572717Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-10-10T15:31:48.283584230Z -- 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-10T15:31:48.283599191Z    -> 0.0010s
2025-10-10T15:31:48.283607457Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0014s) ==============
2025-10-10T15:31:48.283617888Z 
2025-10-10T15:31:48.283627477Z Migrating to CreateProblems (20221210001132)
2025-10-10T15:31:48.283637488Z == 20221210001132 CreateProblems: migrating ===================================
2025-10-10T15:31:48.283647578Z -- create_table(:problems)
2025-10-10T15:31:48.283655684Z    -> 0.0010s
2025-10-10T15:31:48.283663610Z == 20221210001132 CreateProblems: migrated (0.0014s) ==========================
2025-10-10T15:31:48.283671757Z 
2025-10-10T15:31:48.283679612Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-10-10T15:31:48.283687689Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-10-10T15:31:48.283695785Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0184s) ========
2025-10-10T15:31:48.283703901Z 
2025-10-10T15:31:48.283711667Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-10-10T15:31:48.283722278Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-10-10T15:31:48.283732569Z -- create_table(:favorites, {force: true})
2025-10-10T15:31:48.283742559Z    -> 0.0046s
2025-10-10T15:31:48.283753181Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-10-10T15:31:48.283764403Z    -> 0.0001s
2025-10-10T15:31:48.283774443Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-10-10T15:31:48.283785355Z    -> 0.0001s
2025-10-10T15:31:48.283810376Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-10-10T15:31:48.283822390Z    -> 0.0001s
2025-10-10T15:31:48.283832510Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0056s) ================
2025-10-10T15:31:48.283842841Z 
2025-10-10T15:31:48.283873122Z Migrating to MovePrintedToFavorites (20221220223040)
2025-10-10T15:31:48.283881559Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-10-10T15:31:48.283889655Z == 20221220223040 MovePrintedToFavorites: migrated (0.0623s) ==================
2025-10-10T15:31:48.283897702Z 
2025-10-10T15:31:48.283905447Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-10-10T15:31:48.283913954Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-10-10T15:31:48.283923874Z -- remove_column(:model_files, :printed, :boolean)
2025-10-10T15:31:48.283933674Z    -> 0.0288s
2025-10-10T15:31:48.283944085Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0292s) ===============
2025-10-10T15:31:48.283954596Z 
2025-10-10T15:31:48.283964276Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-10-10T15:31:48.283976300Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-10-10T15:31:48.283986681Z -- add_column(:models, :notes, :text)
2025-10-10T15:31:48.283996982Z    -> 0.0012s
2025-10-10T15:31:48.284006962Z -- add_column(:models, :excerpt, :text)
2025-10-10T15:31:48.284017282Z    -> 0.0023s
2025-10-10T15:31:48.284027784Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0036s) =================
2025-10-10T15:31:48.284038575Z 
2025-10-10T15:31:48.284049147Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-10-10T15:31:48.284059197Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-10-10T15:31:48.284069638Z -- add_column(:creators, :notes, :text)
2025-10-10T15:31:48.284079738Z    -> 0.0006s
2025-10-10T15:31:48.284089909Z -- add_column(:creators, :excerpt, :text)
2025-10-10T15:31:48.284100129Z    -> 0.0005s
2025-10-10T15:31:48.284110580Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0011s) ===============
2025-10-10T15:31:48.284120851Z 
2025-10-10T15:31:48.284129729Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-10-10T15:31:48.284137785Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-10-10T15:31:48.284145861Z -- add_column(:model_files, :notes, :text)
2025-10-10T15:31:48.284154629Z    -> 0.0006s
2025-10-10T15:31:48.284164829Z -- add_column(:model_files, :excerpt, :text)
2025-10-10T15:31:48.284189860Z    -> 0.0005s
2025-10-10T15:31:48.284200381Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0011s) =============
2025-10-10T15:31:48.284210381Z 
2025-10-10T15:31:48.284220401Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-10-10T15:31:48.284230121Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-10-10T15:31:48.284239360Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0214s) =================
2025-10-10T15:31:48.284249580Z 
2025-10-10T15:31:48.284259400Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-10-10T15:31:48.284269781Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-10-10T15:31:48.284280242Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-10-10T15:31:48.284289881Z    -> 0.0493s
2025-10-10T15:31:48.284297857Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0493s) =============
2025-10-10T15:31:48.284306324Z 
2025-10-10T15:31:48.284314090Z Migrating to RenameExcerptToCaption (20230222155910)
2025-10-10T15:31:48.284322016Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-10-10T15:31:48.284330062Z -- rename_column(:creators, :excerpt, :caption)
2025-10-10T15:31:48.284337958Z    -> 0.0224s
2025-10-10T15:31:48.284345904Z -- rename_column(:models, :excerpt, :caption)
2025-10-10T15:31:48.284354151Z    -> 0.0223s
2025-10-10T15:31:48.284361996Z -- rename_column(:model_files, :excerpt, :caption)
2025-10-10T15:31:48.284369902Z    -> 0.0205s
2025-10-10T15:31:48.284377748Z == 20230222155910 RenameExcerptToCaption: migrated (0.0677s) ==================
2025-10-10T15:31:48.284385794Z 
2025-10-10T15:31:48.284393480Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-10-10T15:31:48.284401466Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-10-10T15:31:48.284409843Z -- add_column(:libraries, :notes, :string)
2025-10-10T15:31:48.284419913Z    -> 0.0022s
2025-10-10T15:31:48.284429342Z -- add_column(:libraries, :caption, :string)
2025-10-10T15:31:48.716154942Z    -> 0.0005s
2025-10-10T15:31:48.716193370Z -- add_column(:libraries, :name, :string)
2025-10-10T15:31:48.716198981Z    -> 0.0005s
2025-10-10T15:31:48.716203600Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0126s) ============
2025-10-10T15:31:48.716208570Z 
2025-10-10T15:31:48.716213671Z Migrating to AddTagregexToLibrary (20230305180823)
2025-10-10T15:31:48.716218621Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-10-10T15:31:48.716251647Z -- add_column(:libraries, :tag_regex, :text)
2025-10-10T15:31:48.716257259Z    -> 0.0022s
2025-10-10T15:31:48.716262649Z == 20230305180823 AddTagregexToLibrary: migrated (0.0039s) ====================
2025-10-10T15:31:48.716267760Z 
2025-10-10T15:31:48.716272609Z Migrating to AddIconToLibrary (20230307215826)
2025-10-10T15:31:48.716277890Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-10-10T15:31:48.716283000Z -- add_column(:libraries, :icon, :text)
2025-10-10T15:31:48.716288121Z    -> 0.0021s
2025-10-10T15:31:48.716293091Z == 20230307215826 AddIconToLibrary: migrated (0.0039s) ========================
2025-10-10T15:31:48.716297900Z 
2025-10-10T15:31:48.716302520Z Migrating to CreateCollection (20230308004237)
2025-10-10T15:31:48.716307239Z == 20230308004237 CreateCollection: migrating =================================
2025-10-10T15:31:48.716312169Z -- create_table(:collections)
2025-10-10T15:31:48.716317360Z    -> 0.0029s
2025-10-10T15:31:48.716322320Z == 20230308004237 CreateCollection: migrated (0.0070s) ========================
2025-10-10T15:31:48.716327450Z 
2025-10-10T15:31:48.716332159Z Migrating to AddCollectionToModels (20230308005021)
2025-10-10T15:31:48.716336769Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-10-10T15:31:48.716341869Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-10-10T15:31:48.716346759Z    -> 0.0185s
2025-10-10T15:31:48.716351669Z == 20230308005021 AddCollectionToModels: migrated (0.0226s) ===================
2025-10-10T15:31:48.716356979Z 
2025-10-10T15:31:48.716361719Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-10-10T15:31:48.716366148Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-10-10T15:31:48.716370907Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0015s) =============
2025-10-10T15:31:48.716375667Z 
2025-10-10T15:31:48.716380316Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-10-10T15:31:48.716385226Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-10-10T15:31:48.716389615Z -- rename_column(:collections, :excerpt, :caption)
2025-10-10T15:31:48.716396038Z    -> 0.0051s
2025-10-10T15:31:48.716400587Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0052s) ========
2025-10-10T15:31:48.716405126Z 
2025-10-10T15:31:48.716409525Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-10-10T15:31:48.716414144Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-10-10T15:31:48.716418603Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-10-10T15:31:48.716431269Z 
2025-10-10T15:31:48.716436129Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-10-10T15:31:48.716442351Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-10-10T15:31:48.716447031Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-10-10T15:31:48.716452692Z    -> 0.0016s
2025-10-10T15:31:48.716457221Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0017s) ===============
2025-10-10T15:31:48.716461941Z 
2025-10-10T15:31:48.716466620Z Migrating to AddCollectionToCollections (20230324000000)
2025-10-10T15:31:48.716471209Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-10-10T15:31:48.716475698Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-10-10T15:31:48.716480247Z    -> 0.0066s
2025-10-10T15:31:48.716484616Z == 20230324000000 AddCollectionToCollections: migrated (0.0087s) ==============
2025-10-10T15:31:48.716489366Z 
2025-10-10T15:31:48.716493705Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-10-10T15:31:48.716498304Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-10-10T15:31:48.716503384Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0451s) =========
2025-10-10T15:31:48.716508084Z 
2025-10-10T15:31:48.716512683Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-10-10T15:31:48.716517472Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-10-10T15:31:48.716522002Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0062s) 
2025-10-10T15:31:48.716526741Z 
2025-10-10T15:31:48.716531280Z Migrating to AddSlugs (20230615135601)
2025-10-10T15:31:48.716536240Z == 20230615135601 AddSlugs: migrating =========================================
2025-10-10T15:31:48.716541100Z -- add_column(:models, :slug, :string)
2025-10-10T15:31:48.716546341Z    -> 0.0026s
2025-10-10T15:31:48.716550860Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-10-10T15:31:48.716555689Z    -> 0.0020s
2025-10-10T15:31:48.716560669Z -- add_column(:collections, :slug, :string)
2025-10-10T15:31:48.716566311Z    -> 0.0005s
2025-10-10T15:31:48.716570910Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-10-10T15:31:48.716576090Z    -> 0.0002s
2025-10-10T15:31:48.716580990Z -- add_column(:creators, :slug, :string)
2025-10-10T15:31:48.716586331Z    -> 0.0008s
2025-10-10T15:31:48.716591031Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-10-10T15:31:48.716604387Z    -> 0.0001s
2025-10-10T15:31:48.716609598Z == 20230615135601 AddSlugs: migrated (0.0067s) ================================
2025-10-10T15:31:48.716614628Z 
2025-10-10T15:31:48.716620039Z Migrating to GenerateSlugs (20230617222353)
2025-10-10T15:31:48.716625079Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-10-10T15:31:48.716629869Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-10-10T15:31:48.716634678Z 
2025-10-10T15:31:48.716639188Z Migrating to MakeNamesUnique (20230628194944)
2025-10-10T15:31:48.716644208Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-10-10T15:31:48.716649669Z == 20230628194944 MakeNamesUnique: migrated (0.0032s) =========================
2025-10-10T15:31:48.716654438Z 
2025-10-10T15:31:48.716658887Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-10-10T15:31:48.716663667Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-10-10T15:31:48.716668226Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-10-10T15:31:48.716673036Z    -> 0.0021s
2025-10-10T15:31:48.716677655Z -- remove_index(:creators, :slug)
2025-10-10T15:31:48.716682485Z    -> 0.0004s
2025-10-10T15:31:48.716686944Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-10-10T15:31:48.716691353Z    -> 0.0002s
2025-10-10T15:31:48.716695962Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-10-10T15:31:48.716700832Z    -> 0.0002s
2025-10-10T15:31:48.716705311Z -- remove_index(:collections, :slug)
2025-10-10T15:31:48.716710070Z    -> 0.0232s
2025-10-10T15:31:48.716714700Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-10-10T15:31:48.716721413Z    -> 0.0006s
2025-10-10T15:31:48.716726022Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0271s) ======
2025-10-10T15:31:48.716730602Z 
2025-10-10T15:31:48.716735171Z Migrating to AddSizeToModelFiles (20230707082403)
2025-10-10T15:31:48.716739890Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-10-10T15:31:48.716744750Z -- add_column(:model_files, :size, :integer)
2025-10-10T15:31:48.716749500Z    -> 0.0007s
2025-10-10T15:31:48.716754179Z == 20230707082403 AddSizeToModelFiles: migrated (0.0010s) =====================
2025-10-10T15:31:48.716758879Z 
2025-10-10T15:31:48.716763197Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-10-10T15:31:48.716767997Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-10-10T15:31:48.716780552Z -- change_column(:model_files, :size, :bigint)
2025-10-10T15:31:48.716785382Z    -> 0.0084s
2025-10-10T15:31:48.716790001Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0087s) ==================
2025-10-10T15:31:48.716794681Z 
2025-10-10T15:31:48.716799230Z Migrating to AddNoteToProblems (20230711111009)
2025-10-10T15:31:48.716803919Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-10-10T15:31:48.716808629Z -- add_column(:problems, :note, :string, {default: nil})
2025-10-10T15:31:48.716813298Z    -> 0.0012s
2025-10-10T15:31:48.716817897Z == 20230711111009 AddNoteToProblems: migrated (0.0022s) =======================
2025-10-10T15:31:48.716822547Z 
2025-10-10T15:31:48.716826845Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-10-10T15:31:48.716831715Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-10-10T15:31:48.716837477Z -- 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-10T15:31:48.716846445Z    -> 0.0006s
2025-10-10T15:31:48.716850944Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-10-10T15:31:48.716855613Z 
2025-10-10T15:31:48.716860663Z Migrating to AddLicenseToModel (20240127143358)
2025-10-10T15:31:48.716865513Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-10-10T15:31:48.716870634Z -- add_column(:models, :license, :string)
2025-10-10T15:31:48.716874992Z    -> 0.0006s
2025-10-10T15:31:48.716879341Z == 20240127143358 AddLicenseToModel: migrated (0.0007s) =======================
2025-10-10T15:31:48.716884321Z 
2025-10-10T15:31:48.716888800Z Migrating to AddIgnoredToProblems (20240131134832)
2025-10-10T15:31:48.716893560Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-10-10T15:31:48.716898159Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-10-10T15:31:48.716902929Z    -> 0.0006s
2025-10-10T15:31:48.716907678Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-10-10T15:31:48.716912368Z 
2025-10-10T15:31:48.716916877Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-10-10T15:31:48.716921235Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-10-10T15:31:48.716926256Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-10-10T15:31:48.716937839Z    -> 0.0097s
2025-10-10T15:31:48.716942288Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0097s) ======
2025-10-10T15:31:48.716947007Z 
2025-10-10T15:31:48.716951526Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-10-10T15:31:48.716956336Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-10-10T15:31:48.716961106Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-10-10T15:31:48.716965815Z    -> 0.0006s
2025-10-10T15:31:48.716970304Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-10-10T15:31:48.716975244Z 
2025-10-10T15:31:48.716979623Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-10-10T15:31:48.716984312Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-10-10T15:31:48.716989292Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-10-10T15:31:48.716993661Z    -> 0.0002s
2025-10-10T15:31:48.716998331Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-10-10T15:31:48.717003391Z    -> 0.0009s
2025-10-10T15:31:48.717007569Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-10-10T15:31:48.717011718Z    -> 0.0002s
2025-10-10T15:31:48.717015766Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-10-10T15:31:48.717020044Z    -> 0.0043s
2025-10-10T15:31:49.265891158Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0058s) =================
2025-10-10T15:31:49.265920407Z 
2025-10-10T15:31:49.265929786Z Migrating to CreateFlipperTables (20240306095646)
2025-10-10T15:31:49.265938383Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-10-10T15:31:49.265947131Z -- create_table(:flipper_features)
2025-10-10T15:31:49.265955387Z    -> 0.0028s
2025-10-10T15:31:49.265963754Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-10-10T15:31:49.265972301Z    -> 0.0053s
2025-10-10T15:31:49.265980398Z -- create_table(:flipper_gates)
2025-10-10T15:31:49.265988464Z    -> 0.0003s
2025-10-10T15:31:49.265996700Z -- 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-10T15:31:49.266005488Z    -> 0.0002s
2025-10-10T15:31:49.266013574Z == 20240306095646 CreateFlipperTables: migrated (0.0086s) =====================
2025-10-10T15:31:49.266049737Z 
2025-10-10T15:31:49.266057733Z Migrating to RolifyCreateRoles (20240319155251)
2025-10-10T15:31:49.266065770Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-10-10T15:31:49.266073916Z -- create_table(:roles)
2025-10-10T15:31:49.266082433Z    -> 0.0425s
2025-10-10T15:31:49.266092604Z -- create_table(:users_roles, {id: false})
2025-10-10T15:31:49.266103035Z    -> 0.0006s
2025-10-10T15:31:49.266113055Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-10-10T15:31:49.266122975Z    -> 0.0053s
2025-10-10T15:31:49.266131782Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-10-10T15:31:49.266140249Z    -> 0.0002s
2025-10-10T15:31:49.266148256Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-10-10T15:31:49.266156753Z    -> 0.0001s
2025-10-10T15:31:49.266165320Z == 20240319155251 RolifyCreateRoles: migrated (0.0669s) =======================
2025-10-10T15:31:49.266173436Z 
2025-10-10T15:31:49.266181392Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-10-10T15:31:49.266189398Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-10-10T15:31:49.266197625Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0072s) ==================
2025-10-10T15:31:49.266205832Z 
2025-10-10T15:31:49.266213617Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-10-10T15:31:49.266221583Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-10-10T15:31:49.266230812Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-10T15:31:49.266241062Z    -> 0.0292s
2025-10-10T15:31:49.266251283Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0307s) ====================
2025-10-10T15:31:49.266261854Z 
2025-10-10T15:31:49.266270121Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-10-10T15:31:49.266278338Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-10-10T15:31:49.266286604Z -- add_column(:users, :reset_password_token, :string)
2025-10-10T15:31:49.266296123Z    -> 0.0015s
2025-10-10T15:31:49.266306244Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-10-10T15:31:49.266318879Z    -> 0.0002s
2025-10-10T15:31:49.266329551Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0038s) ============
2025-10-10T15:31:49.266340132Z 
2025-10-10T15:31:49.266349872Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-10-10T15:31:49.266373469Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-10-10T15:31:49.266384040Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0261s) ==============
2025-10-10T15:31:49.266394311Z 
2025-10-10T15:31:49.266404401Z Migrating to AddRememberableToUsers (20240410221112)
2025-10-10T15:31:49.266414782Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-10-10T15:31:49.266425143Z -- add_column(:users, :remember_created_at, :datetime)
2025-10-10T15:31:49.266435354Z    -> 0.0034s
2025-10-10T15:31:49.266445324Z == 20240410221112 AddRememberableToUsers: migrated (0.0047s) ==================
2025-10-10T15:31:49.266454562Z 
2025-10-10T15:31:49.266462558Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-10-10T15:31:49.266470625Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-10-10T15:31:49.266479302Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-10-10T15:31:49.266487459Z    -> 0.0007s
2025-10-10T15:31:49.266495775Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0019s) ===========
2025-10-10T15:31:49.266503952Z 
2025-10-10T15:31:49.266511778Z Migrating to DropDelayedJobs (20240418112821)
2025-10-10T15:31:49.266519734Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-10-10T15:31:49.266527820Z -- drop_table(:delayed_jobs)
2025-10-10T15:31:49.266536437Z    -> 0.0021s
2025-10-10T15:31:49.266546528Z == 20240418112821 DropDelayedJobs: migrated (0.0124s) =========================
2025-10-10T15:31:49.266556788Z 
2025-10-10T15:31:49.266567319Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-10-10T15:31:49.266578181Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-10-10T15:31:49.266588542Z -- add_column(:users, :interface_language, :string)
2025-10-10T15:31:49.266598252Z    -> 0.0007s
2025-10-10T15:31:49.266606268Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0042s) =============
2025-10-10T15:31:49.266614404Z 
2025-10-10T15:31:49.266622300Z Migrating to AddLockableToUsers (20240610120318)
2025-10-10T15:31:49.266630396Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-10-10T15:31:49.266638693Z -- change_table(:users)
2025-10-10T15:31:49.266646629Z    -> 0.0017s
2025-10-10T15:31:49.266654545Z == 20240610120318 AddLockableToUsers: migrated (0.0021s) ======================
2025-10-10T15:31:49.266662641Z 
2025-10-10T15:31:49.266670377Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-10-10T15:31:49.266680147Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-10-10T15:31:49.266705518Z -- add_column(:model_files, :attachment_data, :json)
2025-10-10T15:31:49.266716189Z    -> 0.0006s
2025-10-10T15:31:49.266726269Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0010s) ===========
2025-10-10T15:31:49.266735298Z 
2025-10-10T15:31:49.266743133Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-10-10T15:31:49.266751951Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-10-10T15:31:49.266760138Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0231s) ==================
2025-10-10T15:31:49.266768264Z 
2025-10-10T15:31:49.266777663Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-10-10T15:31:49.266787813Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-10-10T15:31:49.266798435Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-10-10T15:31:49.266809056Z    -> 0.0007s
2025-10-10T15:31:49.266818816Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0027s) ============
2025-10-10T15:31:49.266828716Z 
2025-10-10T15:31:49.266838195Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-10-10T15:31:49.266848345Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-10-10T15:31:49.266858365Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-10-10T15:31:49.266866582Z    -> 0.0006s
2025-10-10T15:31:49.266875219Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-10-10T15:31:49.266883286Z    -> 0.0006s
2025-10-10T15:31:49.266891292Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-10-10T15:31:49.266899338Z    -> 0.0006s
2025-10-10T15:31:49.266907605Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-10-10T15:31:49.266915701Z    -> 0.0053s
2025-10-10T15:31:49.266923998Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-10-10T15:31:49.266933667Z    -> 0.0006s
2025-10-10T15:31:49.266943487Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0090s) ====================
2025-10-10T15:31:49.266953597Z 
2025-10-10T15:31:49.266963257Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-10-10T15:31:49.266972425Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-10-10T15:31:49.266980702Z -- remove_index(:libraries, :path)
2025-10-10T15:31:49.266988878Z    -> 0.0012s
2025-10-10T15:31:49.266997075Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0022s) ================
2025-10-10T15:31:49.267005301Z 
2025-10-10T15:31:49.267013217Z Migrating to CreateFederailsActors (20240727113215)
2025-10-10T15:31:49.267032997Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-10-10T15:31:49.267043448Z -- create_table(:federails_actors)
2025-10-10T15:31:49.267053298Z    -> 0.0011s
2025-10-10T15:31:49.267063729Z -- foreign_key_exists?(:federails_actors, :users)
2025-10-10T15:31:49.267073589Z    -> 0.0016s
2025-10-10T15:31:49.267084390Z -- remove_foreign_key(:federails_actors, :users)
2025-10-10T15:31:49.267094571Z    -> 0.0121s
2025-10-10T15:31:49.267104731Z -- remove_index(:federails_actors, :user_id)
2025-10-10T15:31:49.267115203Z    -> 0.0004s
2025-10-10T15:31:49.267128109Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-10-10T15:31:49.267138940Z    -> 0.0001s
2025-10-10T15:31:49.267149161Z -- add_foreign_key(:federails_actors, :users)
2025-10-10T15:31:49.267159592Z    -> 0.0101s
2025-10-10T15:31:49.267170273Z == 20240727113215 CreateFederailsActors: migrated (0.0263s) ===================
2025-10-10T15:31:49.267180384Z 
2025-10-10T15:31:49.267190745Z Migrating to CreateFederailsFollowings (20240727113216)
2025-10-10T15:31:49.267202398Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-10-10T15:31:49.267212478Z -- create_table(:federails_followings)
2025-10-10T15:31:49.267222258Z    -> 0.0012s
2025-10-10T15:31:49.267232619Z == 20240727113216 CreateFederailsFollowings: migrated (0.0012s) ===============
2025-10-10T15:31:49.267242419Z 
2025-10-10T15:31:49.267252218Z Migrating to CreateFederailsActivities (20240727113217)
2025-10-10T15:31:49.267261878Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-10-10T15:31:49.267271868Z -- create_table(:federails_activities)
2025-10-10T15:31:49.267281598Z    -> 0.0092s
2025-10-10T15:31:49.267291067Z == 20240727113217 CreateFederailsActivities: migrated (0.0093s) ===============
2025-10-10T15:31:49.267300776Z 
2025-10-10T15:31:49.267310035Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-10-10T15:31:49.267320356Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-10-10T15:31:49.267330586Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-10-10T15:31:49.267341438Z    -> 0.0082s
2025-10-10T15:31:49.267351538Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-10-10T15:31:49.267361869Z    -> 0.0004s
2025-10-10T15:31:49.267371809Z -- change_table(:federails_actors)
2025-10-10T15:31:49.267381930Z    -> 0.0065s
2025-10-10T15:31:49.267392040Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0152s) =======
2025-10-10T15:31:49.267415547Z 
2025-10-10T15:31:49.267424936Z Migrating to CreateFederailsActors (20240731165647)
2025-10-10T15:31:49.267434014Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-10-10T15:31:49.267443894Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-10-10T15:31:49.267454816Z 
2025-10-10T15:31:49.267464997Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-10-10T15:31:49.267475288Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-10-10T15:31:49.267485438Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-10-10T15:31:49.267496150Z 
2025-10-10T15:31:49.267506591Z Migrating to BackfillActivities (20240805111500)
2025-10-10T15:31:49.267517402Z == 20240805111500 BackfillActivities: migrating ===============================
2025-10-10T15:31:49.267527483Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-10-10T15:31:49.267538455Z 
2025-10-10T15:31:49.267546822Z Migrating to CreateCaberRelations (20240827155630)
2025-10-10T15:31:49.267555008Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-10-10T15:31:49.267563395Z -- create_table(:caber_relations)
2025-10-10T15:31:49.267571612Z    -> 0.0433s
2025-10-10T15:31:49.267580249Z == 20240827155630 CreateCaberRelations: migrated (0.0433s) ====================
2025-10-10T15:31:49.267588536Z 
2025-10-10T15:31:49.267596552Z Migrating to AddDefaultAccessControls (20240830121749)
2025-10-10T15:31:49.267604688Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-10-10T15:31:49.267612935Z == 20240830121749 AddDefaultAccessControls: migrated (0.0593s) ================
2025-10-10T15:31:49.267621372Z 
2025-10-10T15:31:49.267630530Z Migrating to RenameDefaultRoles (20240830151650)
2025-10-10T15:31:50.024448616Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-10-10T15:31:50.024491492Z == 20240830151650 RenameDefaultRoles: migrated (0.0435s) ======================
2025-10-10T15:31:50.024500951Z 
2025-10-10T15:31:50.024508987Z Migrating to AddPublicIDsToModels (20240904151944)
2025-10-10T15:31:50.024517154Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-10-10T15:31:50.024525420Z -- add_column(:models, :public_id, :string)
2025-10-10T15:31:50.024533517Z    -> 0.0008s
2025-10-10T15:31:50.024541783Z -- add_index(:models, :public_id)
2025-10-10T15:31:50.024550120Z    -> 0.0035s
2025-10-10T15:31:50.024558136Z -- add_column(:model_files, :public_id, :string)
2025-10-10T15:31:50.024595882Z    -> 0.0007s
2025-10-10T15:31:50.024603948Z -- add_index(:model_files, :public_id)
2025-10-10T15:31:50.024611864Z    -> 0.0002s
2025-10-10T15:31:50.024619830Z -- add_column(:problems, :public_id, :string)
2025-10-10T15:31:50.024628097Z    -> 0.0007s
2025-10-10T15:31:50.024635993Z -- add_index(:problems, :public_id)
2025-10-10T15:31:50.024644200Z    -> 0.0001s
2025-10-10T15:31:50.024652366Z -- add_column(:creators, :public_id, :string)
2025-10-10T15:31:50.024660603Z    -> 0.0006s
2025-10-10T15:31:50.024668599Z -- add_index(:creators, :public_id)
2025-10-10T15:31:50.024676595Z    -> 0.0002s
2025-10-10T15:31:50.024684571Z -- add_column(:collections, :public_id, :string)
2025-10-10T15:31:50.024692577Z    -> 0.0007s
2025-10-10T15:31:50.024700453Z -- add_index(:collections, :public_id)
2025-10-10T15:31:50.024708840Z    -> 0.0002s
2025-10-10T15:31:50.024716906Z -- add_column(:libraries, :public_id, :string)
2025-10-10T15:31:50.024725052Z    -> 0.0006s
2025-10-10T15:31:50.024732928Z -- add_index(:libraries, :public_id)
2025-10-10T15:31:50.024741024Z    -> 0.0002s
2025-10-10T15:31:50.024749081Z == 20240904151944 AddPublicIDsToModels: migrated (0.0086s) ====================
2025-10-10T15:31:50.024757227Z 
2025-10-10T15:31:50.024765303Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-10-10T15:31:50.024773520Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-10-10T15:31:50.024781626Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:50.024789813Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0538s) ==============
2025-10-10T15:31:50.024798029Z 
2025-10-10T15:31:50.024805765Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-10-10T15:31:50.024814031Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-10-10T15:31:50.024822048Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-10-10T15:31:50.024830274Z 
2025-10-10T15:31:50.024838431Z Migrating to DeduplicateRoles (20240923114515)
2025-10-10T15:31:50.024846427Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-10-10T15:31:50.024854763Z == 20240923114515 DeduplicateRoles: migrated (0.1667s) ========================
2025-10-10T15:31:50.024862840Z 
2025-10-10T15:31:50.024870926Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-10-10T15:31:50.024879153Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-10-10T15:31:50.024887169Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-10T15:31:50.024905546Z    -> 0.1762s
2025-10-10T15:31:50.024915406Z -- add_index(:models, :name_lower)
2025-10-10T15:31:50.024923632Z    -> 0.0002s
2025-10-10T15:31:50.024931839Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-10T15:31:50.024940747Z    -> 0.0068s
2025-10-10T15:31:50.024948803Z -- add_index(:creators, :name_lower)
2025-10-10T15:31:50.024956889Z    -> 0.0002s
2025-10-10T15:31:50.024964915Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-10T15:31:50.024973242Z    -> 0.0090s
2025-10-10T15:31:50.024981659Z -- add_index(:collections, :name_lower)
2025-10-10T15:31:50.024989665Z    -> 0.0002s
2025-10-10T15:31:50.024997812Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1927s) =============
2025-10-10T15:31:50.025006259Z 
2025-10-10T15:31:50.025014195Z Migrating to AddKeypairToActors (20240926162407)
2025-10-10T15:31:50.025022311Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-10-10T15:31:50.025030618Z -- change_table(:federails_actors)
2025-10-10T15:31:50.025039075Z    -> 0.0017s
2025-10-10T15:31:50.025047572Z == 20240926162407 AddKeypairToActors: migrated (0.0018s) ======================
2025-10-10T15:31:50.025055668Z 
2025-10-10T15:31:50.025063464Z Migrating to AddUuids (20241004194445)
2025-10-10T15:31:50.025071530Z == 20241004194445 AddUuids: migrating =========================================
2025-10-10T15:31:50.025079666Z -- change_table(:federails_actors)
2025-10-10T15:31:50.025087622Z    -> 0.0036s
2025-10-10T15:31:50.025095568Z -- change_table(:federails_activities)
2025-10-10T15:31:50.025103574Z    -> 0.0010s
2025-10-10T15:31:50.025111791Z -- change_table(:federails_followings)
2025-10-10T15:31:50.025119937Z    -> 0.0010s
2025-10-10T15:31:50.025127873Z == 20241004194445 AddUuids: migrated (0.0056s) ================================
2025-10-10T15:31:50.025136180Z 
2025-10-10T15:31:50.025144046Z Migrating to CreateComments (20241007182824)
2025-10-10T15:31:50.025152072Z == 20241007182824 CreateComments: migrating ===================================
2025-10-10T15:31:50.025160549Z -- create_table(:comments)
2025-10-10T15:31:50.025168786Z    -> 0.0022s
2025-10-10T15:31:50.025176912Z == 20241007182824 CreateComments: migrated (0.0023s) ==========================
2025-10-10T15:31:50.025185189Z 
2025-10-10T15:31:50.025192995Z Migrating to AddSystemToComments (20241009122540)
2025-10-10T15:31:50.025210329Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-10-10T15:31:50.025218446Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-10-10T15:31:50.025226542Z    -> 0.0015s
2025-10-10T15:31:50.025234508Z == 20241009122540 AddSystemToComments: migrated (0.0016s) =====================
2025-10-10T15:31:50.025242604Z 
2025-10-10T15:31:50.025250470Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-10-10T15:31:50.025258496Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-10-10T15:31:50.025266583Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0022s) ============
2025-10-10T15:31:50.025274829Z 
2025-10-10T15:31:50.025283016Z Migrating to AddOmniauthToUsers (20241015090803)
2025-10-10T15:31:50.025290992Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-10-10T15:31:50.025299208Z -- add_column(:users, :auth_provider, :string)
2025-10-10T15:31:50.025307194Z    -> 0.0013s
2025-10-10T15:31:50.025315431Z -- add_column(:users, :auth_uid, :string)
2025-10-10T15:31:50.025323798Z    -> 0.0010s
2025-10-10T15:31:50.025331794Z == 20241015090803 AddOmniauthToUsers: migrated (0.0023s) ======================
2025-10-10T15:31:50.025340011Z 
2025-10-10T15:31:50.025347977Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-10-10T15:31:50.025356253Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-10-10T15:31:50.025364390Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-10-10T15:31:50.025372606Z    -> 0.0013s
2025-10-10T15:31:50.025380893Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-10-10T15:31:50.025389149Z    -> 0.0010s
2025-10-10T15:31:50.025397156Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0023s) =====
2025-10-10T15:31:50.025405312Z 
2025-10-10T15:31:50.025413148Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-10-10T15:31:50.025421224Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-10-10T15:31:50.025429270Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-10-10T15:31:50.025437707Z    -> 0.0013s
2025-10-10T15:31:50.025445824Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0013s) ======
2025-10-10T15:31:50.025453880Z 
2025-10-10T15:31:50.025461625Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-10-10T15:31:50.025469601Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-10-10T15:31:50.025477688Z -- change_table(:users)
2025-10-10T15:31:50.025487477Z    -> 0.0013s
2025-10-10T15:31:50.025504913Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0014s) =====================
2025-10-10T15:31:50.025513279Z 
2025-10-10T15:31:50.025521666Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-10-10T15:31:50.025529662Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-10-10T15:31:50.025538009Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0050s) =================
2025-10-10T15:31:50.025546576Z 
2025-10-10T15:31:50.025554462Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-10-10T15:31:50.025562669Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-10-10T15:31:50.025571426Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-10-10T15:31:50.025580344Z    -> 0.0010s
2025-10-10T15:31:50.025588411Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-10-10T15:31:50.025596908Z    -> 0.0014s
2025-10-10T15:31:50.025604954Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-10-10T15:31:50.025613301Z    -> 0.0005s
2025-10-10T15:31:50.025621467Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-10-10T15:31:50.025630024Z    -> 0.0020s
2025-10-10T15:31:50.025638391Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-10-10T15:31:50.025646898Z    -> 0.0009s
2025-10-10T15:31:50.025655225Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-10-10T15:31:50.025663452Z    -> 0.0008s
2025-10-10T15:31:50.025671949Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-10-10T15:31:50.025680406Z    -> 0.0005s
2025-10-10T15:31:50.025688282Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0072s) ===================
2025-10-10T15:31:50.025696398Z 
2025-10-10T15:31:50.025704184Z Migrating to AddInProgressToProblems (20241105121830)
2025-10-10T15:31:50.025712240Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-10-10T15:31:50.025720597Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-10-10T15:31:50.025728663Z    -> 0.0013s
2025-10-10T15:31:50.025736609Z == 20241105121830 AddInProgressToProblems: migrated (0.0013s) =================
2025-10-10T15:31:50.025744866Z 
2025-10-10T15:31:50.025752822Z Migrating to ClearStuckProblems (20241118155027)
2025-10-10T15:31:50.025760938Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-10-10T15:31:50.025769235Z == 20241118155027 ClearStuckProblems: migrated (0.0236s) ======================
2025-10-10T15:31:50.025787061Z 
2025-10-10T15:31:50.025795107Z Migrating to AddApprovedToUser (20241122121621)
2025-10-10T15:31:50.025803133Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-10-10T15:31:50.025811229Z -- change_table(:users)
2025-10-10T15:31:50.025819205Z    -> 0.0033s
2025-10-10T15:31:50.025827161Z == 20241122121621 AddApprovedToUser: migrated (0.0033s) =======================
2025-10-10T15:31:50.025835288Z 
2025-10-10T15:31:50.025843224Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-10-10T15:31:50.025851410Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-10-10T15:31:50.025859847Z -- create_table(:federails_moderation_reports)
2025-10-10T15:31:50.025867974Z    -> 0.0035s
2025-10-10T15:31:50.025876330Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0035s) ========
2025-10-10T15:31:50.025884437Z 
2025-10-10T15:31:50.025892343Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-10-10T15:31:50.025900790Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-10-10T15:31:50.025909136Z -- create_table(:federails_moderation_domain_blocks)
2025-10-10T15:31:50.025917283Z    -> 0.0006s
2025-10-10T15:31:50.025925710Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0006s) ===
2025-10-10T15:31:50.025933966Z 
2025-10-10T15:31:50.025941872Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-10-10T15:31:50.025950069Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-10-10T15:31:50.025958275Z -- change_column_null(:comments, :commenter_id, true)
2025-10-10T15:31:50.025966282Z    -> 0.0088s
2025-10-10T15:31:50.025974197Z -- change_column_null(:comments, :commenter_type, true)
2025-10-10T15:31:50.025982174Z    -> 0.0093s
2025-10-10T15:31:50.025990120Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-10-10T15:31:50.025998226Z    -> 0.0011s
2025-10-10T15:31:50.026006122Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-10-10T15:31:50.026014218Z    -> 0.0132s
2025-10-10T15:31:50.834860783Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0352s) =======
2025-10-10T15:31:50.834901676Z 
2025-10-10T15:31:50.834910794Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-10-10T15:31:50.834919512Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-10-10T15:31:50.834927848Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-10-10T15:31:50.834966957Z    -> 0.0009s
2025-10-10T15:31:50.834975344Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0009s) =================
2025-10-10T15:31:50.834983701Z 
2025-10-10T15:31:50.834992118Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-10-10T15:31:50.835000234Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-10-10T15:31:50.835008290Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1249s) ==================
2025-10-10T15:31:50.835016637Z 
2025-10-10T15:31:50.835024583Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-10-10T15:31:50.835032649Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-10-10T15:31:50.835040686Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-10-10T15:31:50.835048812Z    -> 0.0020s
2025-10-10T15:31:50.835056788Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0020s) ==========
2025-10-10T15:31:50.835064874Z 
2025-10-10T15:31:50.835072670Z Migrating to AddCreatorToCollections (20250222000000)
2025-10-10T15:31:50.835080997Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-10-10T15:31:50.835089273Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-10-10T15:31:50.835097750Z    -> 0.0345s
2025-10-10T15:31:50.835105947Z == 20250222000000 AddCreatorToCollections: migrated (0.0345s) =================
2025-10-10T15:31:50.835114514Z 
2025-10-10T15:31:50.835122691Z Migrating to AddLocalToActors (20250305171530)
2025-10-10T15:31:50.835130787Z == 20250305171530 AddLocalToActors: migrating =================================
2025-10-10T15:31:50.835138803Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-10-10T15:31:50.835147330Z    -> 0.0010s
2025-10-10T15:31:50.835155557Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-10-10T15:31:50.835164054Z    -> 0.0020s
2025-10-10T15:31:50.835172200Z    -> 0 rows
2025-10-10T15:31:50.835180397Z == 20250305171530 AddLocalToActors: migrated (0.0065s) ========================
2025-10-10T15:31:50.835189104Z 
2025-10-10T15:31:50.835197241Z Migrating to AddActorTypeToActors (20250407160721)
2025-10-10T15:31:50.835205477Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-10-10T15:31:50.835213814Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-10-10T15:31:50.835221820Z    -> 0.0009s
2025-10-10T15:31:50.835229706Z == 20250407160721 AddActorTypeToActors: migrated (0.0010s) ====================
2025-10-10T15:31:50.835238203Z 
2025-10-10T15:31:50.835246139Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-10-10T15:31:50.835264667Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-10-10T15:31:50.835275178Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-10-10T15:31:50.835283334Z    -> 0.0015s
2025-10-10T15:31:50.835291691Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0015s) =================
2025-10-10T15:31:50.835300228Z 
2025-10-10T15:31:50.835308134Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-10-10T15:31:50.835316301Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-10-10T15:31:50.835324347Z -- create_table(:oauth_applications)
2025-10-10T15:31:50.835332734Z    -> 0.0005s
2025-10-10T15:31:50.835341110Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-10-10T15:31:50.835349527Z    -> 0.0002s
2025-10-10T15:31:50.835360119Z -- create_table(:oauth_access_grants)
2025-10-10T15:31:50.835368686Z    -> 0.0006s
2025-10-10T15:31:50.835376642Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-10-10T15:31:50.835384859Z    -> 0.0001s
2025-10-10T15:31:50.835392965Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-10-10T15:31:50.835401402Z    -> 0.0075s
2025-10-10T15:31:50.835409709Z -- create_table(:oauth_access_tokens)
2025-10-10T15:31:50.835417845Z    -> 0.0006s
2025-10-10T15:31:50.835426172Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-10-10T15:31:50.835434178Z    -> 0.0001s
2025-10-10T15:31:50.835442384Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-10-10T15:31:50.835450711Z    -> 0.0001s
2025-10-10T15:31:50.835458587Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-10-10T15:31:50.835466743Z    -> 0.0094s
2025-10-10T15:31:50.835474589Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-10-10T15:31:50.835482635Z    -> 0.0078s
2025-10-10T15:31:50.835490551Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-10-10T15:31:50.835498547Z    -> 0.0128s
2025-10-10T15:31:50.835506574Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0400s) ==================
2025-10-10T15:31:50.835514610Z 
2025-10-10T15:31:50.835522345Z Migrating to AddOwnerToApplication (20250408145956)
2025-10-10T15:31:50.835530722Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-10-10T15:31:50.835538758Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-10-10T15:31:50.835546795Z    -> 0.0013s
2025-10-10T15:31:50.835564681Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-10-10T15:31:50.835572747Z    -> 0.0009s
2025-10-10T15:31:50.835580683Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-10-10T15:31:50.835589100Z    -> 0.0002s
2025-10-10T15:31:50.835596996Z == 20250408145956 AddOwnerToApplication: migrated (0.0079s) ===================
2025-10-10T15:31:50.835604992Z 
2025-10-10T15:31:50.835612797Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-10-10T15:31:50.835620784Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-10-10T15:31:50.835628840Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-10-10T15:31:50.835636876Z    -> 0.0110s
2025-10-10T15:31:50.835644712Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0125s) ============
2025-10-10T15:31:50.835652728Z 
2025-10-10T15:31:50.835660924Z Migrating to AddQuotaToUsers (20250409125753)
2025-10-10T15:31:50.835669752Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-10-10T15:31:50.835677798Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-10-10T15:31:50.835685895Z    -> 0.0012s
2025-10-10T15:31:50.835693821Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-10-10T15:31:50.835701917Z    -> 0.0010s
2025-10-10T15:31:50.835709773Z == 20250409125753 AddQuotaToUsers: migrated (0.0038s) =========================
2025-10-10T15:31:50.835717829Z 
2025-10-10T15:31:50.835725555Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-10-10T15:31:50.835733621Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-10-10T15:31:50.835741647Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-10-10T15:31:50.835750385Z    -> 0.0132s
2025-10-10T15:31:50.835758541Z -- add_index(:model_files, :filename_lower)
2025-10-10T15:31:50.835766547Z    -> 0.0002s
2025-10-10T15:31:50.835775565Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0151s) 
2025-10-10T15:31:50.835784463Z 
2025-10-10T15:31:50.835793121Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-10-10T15:31:50.835802049Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-10-10T15:31:50.835810145Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-10-10T15:31:50.835818432Z    -> 0.0002s
2025-10-10T15:31:50.835826568Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0013s) ===================
2025-10-10T15:31:50.835834784Z 
2025-10-10T15:31:50.835842530Z Migrating to AddPreviewToModelFile (20250520111046)
2025-10-10T15:31:50.835876999Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-10-10T15:31:50.835885376Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-10-10T15:31:50.835893563Z    -> 0.0012s
2025-10-10T15:31:50.835901569Z == 20250520111046 AddPreviewToModelFile: migrated (0.0023s) ===================
2025-10-10T15:31:50.835909775Z 
2025-10-10T15:31:50.835917721Z Migrating to CreateAltchaSolutions (20250609210440)
2025-10-10T15:31:50.835925768Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-10-10T15:31:50.835933864Z -- create_table(:altcha_solutions)
2025-10-10T15:31:50.835941850Z    -> 0.0004s
2025-10-10T15:31:50.835950027Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-10-10T15:31:50.835958644Z    -> 0.0002s
2025-10-10T15:31:50.835966530Z == 20250609210440 CreateAltchaSolutions: migrated (0.0018s) ===================
2025-10-10T15:31:50.835975277Z 
2025-10-10T15:31:50.835983574Z Migrating to AddIndexableFields (20250620141805)
2025-10-10T15:31:50.835993153Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-10-10T15:31:50.836001530Z -- change_table(:models)
2025-10-10T15:31:50.836009957Z    -> 0.0028s
2025-10-10T15:31:50.836018164Z -- change_table(:creators)
2025-10-10T15:31:50.836026350Z    -> 0.0020s
2025-10-10T15:31:50.836034487Z -- change_table(:collections)
2025-10-10T15:31:50.836042483Z    -> 0.0020s
2025-10-10T15:31:50.836050779Z == 20250620141805 AddIndexableFields: migrated (0.0070s) ======================
2025-10-10T15:31:50.836059066Z 
2025-10-10T15:31:50.836068174Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-10-10T15:31:50.836076531Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-10-10T15:31:50.836084648Z -- change_column(:models, :indexable, :string)
2025-10-10T15:31:50.836092634Z    -> 0.0383s
2025-10-10T15:31:50.836100680Z -- change_column(:models, :ai_indexable, :string)
2025-10-10T15:31:50.836108957Z    -> 0.0214s
2025-10-10T15:31:50.836117173Z -- change_column(:creators, :indexable, :string)
2025-10-10T15:31:50.836125199Z    -> 0.0103s
2025-10-10T15:31:50.836133145Z -- change_column(:creators, :ai_indexable, :string)
2025-10-10T15:31:50.836141242Z    -> 0.0093s
2025-10-10T15:31:50.836149228Z -- change_column(:collections, :indexable, :string)
2025-10-10T15:31:50.836157194Z    -> 0.0533s
2025-10-10T15:31:50.836165110Z -- change_column(:collections, :ai_indexable, :string)
2025-10-10T15:31:50.836182755Z    -> 0.0140s
2025-10-10T15:31:50.836191032Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1471s) ======
2025-10-10T15:31:50.836199188Z 
2025-10-10T15:31:50.836208246Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-10-10T15:31:50.836216503Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-10-10T15:31:50.836224880Z -- change_table(:models)
2025-10-10T15:31:50.836233106Z    -> 0.0012s
2025-10-10T15:31:50.836242215Z -- change_table(:creators)
2025-10-10T15:31:50.836250662Z    -> 0.0003s
2025-10-10T15:31:50.836259500Z -- change_table(:collections)
2025-10-10T15:31:50.836268969Z    -> 0.0003s
2025-10-10T15:31:50.836277295Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0018s) =================
2025-10-10T15:31:50.836285903Z 
2025-10-10T15:31:50.836293739Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-10-10T15:31:50.836301725Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-10-10T15:31:50.836309721Z -- change_table(:links)
2025-10-10T15:31:50.836317757Z    -> 0.0003s
2025-10-10T15:31:50.836325983Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0003s) =======================
2025-10-10T15:31:50.836334000Z 
2025-10-10T15:31:50.836341825Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-10-10T15:31:50.836350002Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-10-10T15:31:50.836358038Z -- add_column(:links, :synced_at, :datetime)
2025-10-10T15:31:50.836365964Z    -> 0.0012s
2025-10-10T15:31:50.836374000Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0013s) ======================
2025-10-10T15:31:50.836382056Z 
2025-10-10T15:31:50.836389892Z Migrating to CreateFaspClientProviders (20250806142734)
2025-10-10T15:31:50.836397948Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-10-10T15:31:50.836405985Z -- create_table(:fasp_client_providers)
2025-10-10T15:31:50.836413921Z    -> 0.0457s
2025-10-10T15:31:50.836421776Z == 20250806142734 CreateFaspClientProviders: migrated (0.0457s) ===============
2025-10-10T15:31:50.836430073Z 
2025-10-10T15:31:50.836437829Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-10-10T15:31:50.836446085Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-10-10T15:31:50.836454172Z -- create_table(:fasp_client_event_subscriptions)
2025-10-10T15:31:50.836462338Z    -> 0.0147s
2025-10-10T15:31:50.836470214Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0147s) ======
2025-10-10T15:31:50.836487849Z 
2025-10-10T15:31:50.836496647Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-10-10T15:31:50.869276469Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-10-10T15:31:50.869312071Z -- create_table(:fasp_client_backfill_requests)
2025-10-10T15:31:50.869323173Z    -> 0.0057s
2025-10-10T15:31:50.869333394Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0057s) ========
2025-10-10T15:31:50.869343053Z 
2025-10-10T15:31:50.869352162Z Migrating to AddImagesToCreators (20250922155445)
2025-10-10T15:31:50.869361390Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-10-10T15:31:50.869370849Z -- add_column(:creators, :avatar_data, :json)
2025-10-10T15:31:50.869380178Z    -> 0.0012s
2025-10-10T15:31:50.869389326Z -- add_column(:creators, :banner_data, :json)
2025-10-10T15:31:50.869398525Z    -> 0.0009s
2025-10-10T15:31:50.869408715Z == 20250922155445 AddImagesToCreators: migrated (0.0021s) =====================
2025-10-10T15:31:50.869420158Z 
2025-10-10T15:31:50.936372758Z s6-rc: info: service init-manyfold-config successfully started
2025-10-10T15:31:50.936625918Z s6-rc: info: service init-config-end: starting
2025-10-10T15:31:50.938939135Z s6-rc: info: service init-config-end successfully started
2025-10-10T15:31:50.939118927Z s6-rc: info: service init-mods: starting
2025-10-10T15:31:50.940987590Z s6-rc: info: service init-mods successfully started
2025-10-10T15:31:50.941186951Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-10-10T15:31:50.949605512Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-10-10T15:31:50.949794983Z s6-rc: info: service init-mods-package-install: starting
2025-10-10T15:31:50.962167025Z [pkg-install-init] **** Installing all mod packages ****
2025-10-10T15:31:50.974258291Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-10-10T15:31:51.070208006Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-10-10T15:31:51.416594205Z (1/1) Installing redis (8.0.4-r0)
2025-10-10T15:31:51.426342654Z Executing redis-8.0.4-r0.pre-install
2025-10-10T15:31:51.465448063Z Executing redis-8.0.4-r0.post-install
2025-10-10T15:31:51.474081265Z Executing busybox-1.37.0-r19.trigger
2025-10-10T15:31:51.489340470Z OK: 428 MiB in 119 packages
2025-10-10T15:31:51.574783610Z s6-rc: info: service init-mods-package-install successfully started
2025-10-10T15:31:51.574982030Z s6-rc: info: service init-mods-end: starting
2025-10-10T15:31:51.577114985Z s6-rc: info: service init-mods-end successfully started
2025-10-10T15:31:51.577359307Z s6-rc: info: service init-custom-files: starting
2025-10-10T15:31:51.585035863Z [custom-init] No custom files found, skipping...
2025-10-10T15:31:51.585682826Z s6-rc: info: service init-custom-files successfully started
2025-10-10T15:31:51.585858269Z s6-rc: info: service init-services: starting
2025-10-10T15:31:51.587605237Z s6-rc: info: service init-services successfully started
2025-10-10T15:31:51.587793245Z s6-rc: info: service svc-mod-universal-redis: starting
2025-10-10T15:31:51.588011595Z s6-rc: info: service svc-manyfold: starting
2025-10-10T15:31:51.588344886Z s6-rc: info: service svc-cron: starting
2025-10-10T15:31:51.591543306Z s6-rc: info: service svc-cron successfully started
2025-10-10T15:31:51.591778630Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-10-10T15:31:51.601203707Z 281:C 10 Oct 2025 15:31:51.601 # 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-10T15:31:51.601222565Z 281:C 10 Oct 2025 15:31:51.601 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-10-10T15:31:51.601228307Z 281:C 10 Oct 2025 15:31:51.601 * Redis version=8.0.4, bits=64, commit=00000000, modified=1, pid=281, just started
2025-10-10T15:31:51.601233738Z 281:C 10 Oct 2025 15:31:51.601 # 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-10T15:31:51.601851902Z 281:M 10 Oct 2025 15:31:51.601 * monotonic clock: POSIX clock_gettime
2025-10-10T15:31:51.602313872Z 281:M 10 Oct 2025 15:31:51.602 * Running mode=standalone, port=6379.
2025-10-10T15:31:51.602626522Z 281:M 10 Oct 2025 15:31:51.602 * Server initialized
2025-10-10T15:31:51.602656733Z 281:M 10 Oct 2025 15:31:51.602 * Ready to accept connections tcp
2025-10-10T15:31:51.746136289Z 15:31:51 rails.1              | started with pid 301
2025-10-10T15:31:51.746182272Z 15:31:51 default_worker.1     | started with pid 302
2025-10-10T15:31:51.746192002Z 15:31:51 performance_worker.1 | started with pid 303
2025-10-10T15:31:53.614847856Z 15:31:53 default_worker.1     | `/root` is not writable.
2025-10-10T15:31:53.614882976Z 15:31:53 default_worker.1     | Bundler will use `/tmp/bundler20251010-302-8k5307302' as your home directory temporarily.
2025-10-10T15:31:53.623282710Z 15:31:53 performance_worker.1 | `/root` is not writable.
2025-10-10T15:31:53.623328101Z 15:31:53 performance_worker.1 | Bundler will use `/tmp/bundler20251010-303-cgsxk7303' as your home directory temporarily.
2025-10-10T15:31:53.688003014Z 15:31:53 rails.1              | `/root` is not writable.
2025-10-10T15:31:53.688322727Z 15:31:53 rails.1              | Bundler will use `/tmp/bundler20251010-301-cq2fzu301' as your home directory temporarily.
2025-10-10T15:31:55.106637369Z 15:31:55 rails.1              | => Booting Puma
2025-10-10T15:31:55.106711728Z 15:31:55 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-10-10T15:31:55.106721438Z 15:31:55 rails.1              | => Run `bin/rails server --help` for more startup options
2025-10-10T15:31:55.188909894Z 15:31:55 default_worker.1     | Server: f46409e1f5ea, Context: rails, Role: web, data: {cpu: {one_min: 7.05, five_min: 4.29, fifteen_min: 2.86}, memory: 0.19132416e9, disk: {available: 834418753536, total: 938656133120, used: 104237379584}}
2025-10-10T15:31:55.217020736Z 15:31:55 performance_worker.1 | Server: f46409e1f5ea, Context: rails, Role: web, data: {cpu: {one_min: 7.05, five_min: 4.29, fifteen_min: 2.86}, memory: 0.191606784e9, disk: {available: 834418745344, total: 938656133120, used: 104237387776}}
2025-10-10T15:31:57.532125657Z 15:31:57 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:57.532517846Z 15:31:57 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:57.533749136Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.533Z pid=302 tid=246: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-10T15:31:57.533788725Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.533Z pid=303 tid=247: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-10T15:31:57.538321082Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.537Z pid=303 tid=247: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-10T15:31:57.538799836Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.538Z pid=302 tid=246: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-10T15:31:57.539822274Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.539Z pid=303 tid=247: Cron Jobs - added job with name clear-downloads in the namespace default
2025-10-10T15:31:57.592900217Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.592Z pid=303 tid=247: Booted Rails 8.0.2.1 application in production environment
2025-10-10T15:31:57.592935498Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.592Z pid=303 tid=247: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-10T15:31:57.592947883Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.592Z pid=303 tid=247: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-10T15:31:57.592964536Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.592Z pid=303 tid=247: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-10T15:31:57.595438758Z 15:31:57 performance_worker.1 | INFO  2025-10-10T15:31:57.595Z pid=303 tid=247: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-10-10T15:31:57.612097320Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.611Z pid=302 tid=246: Booted Rails 8.0.2.1 application in production environment
2025-10-10T15:31:57.612125216Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.611Z pid=302 tid=246: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-10T15:31:57.612160116Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.611Z pid=302 tid=246: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-10T15:31:57.612173654Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.611Z pid=302 tid=246: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-10T15:31:57.615389409Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.615Z pid=302 tid=246: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-10-10T15:31:57.729739022Z 15:31:57 rails.1              | Server: f46409e1f5ea, Context: rails, Role: web, data: {cpu: {one_min: 7.05, five_min: 4.29, fifteen_min: 2.86}, memory: 0.176574464e9, disk: {available: 834418720768, total: 938656133120, used: 104237412352}}
2025-10-10T15:31:57.729769834Z 15:31:57 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:57.729780065Z 15:31:57 rails.1              | INFO  2025-10-10T15:31:57.533Z pid=301 tid=205: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-10T15:31:57.729814554Z 15:31:57 rails.1              | INFO  2025-10-10T15:31:57.538Z pid=301 tid=205: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-10T15:31:57.729825156Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: eac01fca-02d7-41e7-bd43-12fd74d78fa2) 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-10T15:31:57.729838863Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 544985e3-0af9-4e16-8454-d72d6fc9bdde) 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-10T15:31:57.729858002Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 49176f53-f93d-4a17-9d47-e7501de92c43) 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-10T15:31:57.729868232Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 7f6811f0-ad3e-4eec-816f-55d61283a897) to Sidekiq(upgrade)
2025-10-10T15:31:57.729903884Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 0c1cf045-9aba-40b3-a9e7-bc20e44256d6) to Sidekiq(upgrade)
2025-10-10T15:31:57.733943408Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 080adf1a-3304-4a80-bc94-5a4b7672f5d2) to Sidekiq(upgrade)
2025-10-10T15:31:57.733975392Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 5365e991-0e37-4472-8d2b-fdb2f2ea03be) to Sidekiq(upgrade)
2025-10-10T15:31:57.733984671Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 52375e32-6f1b-494d-ad57-27151dd422ac) to Sidekiq(upgrade)
2025-10-10T15:31:57.734002948Z 15:31:57 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: e32e5b82-51f0-4ab7-b6e9-4e8f855a5944) to Sidekiq(upgrade)
2025-10-10T15:31:57.734012226Z 15:31:57 rails.1              | [301] Puma starting in cluster mode...
2025-10-10T15:31:57.734028780Z 15:31:57 rails.1              | [301] * Puma version: 7.0.4 ("Romantic Warrior")
2025-10-10T15:31:57.734045864Z 15:31:57 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-10T15:31:57.734062738Z 15:31:57 rails.1              | [301] *  Min threads: 4
2025-10-10T15:31:57.734081696Z 15:31:57 rails.1              | [301] *  Max threads: 16
2025-10-10T15:31:57.734103831Z 15:31:57 rails.1              | [301] *  Environment: production
2025-10-10T15:31:57.734138490Z 15:31:57 rails.1              | [301] *   Master PID: 301
2025-10-10T15:31:57.734147028Z 15:31:57 rails.1              | [301] *      Workers: 4
2025-10-10T15:31:57.734186517Z 15:31:57 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-10-10T15:31:57.734199543Z 15:31:57 rails.1              | [301] * Preloading application
2025-10-10T15:31:57.734232880Z 15:31:57 rails.1              | [301] * Listening on http://[::]:3214
2025-10-10T15:31:57.734253853Z 15:31:57 rails.1              | [301] Use Ctrl-C to stop
2025-10-10T15:31:57.761484041Z 15:31:57 rails.1              | [301] - Worker 0 (PID: 378) booted in 0.02s, phase: 0
2025-10-10T15:31:57.761505534Z 15:31:57 rails.1              | [301] - Worker 1 (PID: 391) booted in 0.02s, phase: 0
2025-10-10T15:31:57.761594373Z 15:31:57 rails.1              | [301] - Worker 2 (PID: 404) booted in 0.01s, phase: 0
2025-10-10T15:31:57.763071858Z 15:31:57 rails.1              | [301] - Worker 3 (PID: 417) booted in 0.0s, phase: 0
2025-10-10T15:31:57.858379190Z 15:31:57 performance_worker.1 | Server: f46409e1f5ea, Context: sidekiq, Role: background, data: {cpu: {one_min: 7.28, five_min: 4.39, fifteen_min: 2.9}, memory: 0.236613632e9, disk: {available: 834410500096, total: 938656133120, used: 104245633024}}
2025-10-10T15:31:57.918397337Z 15:31:57 default_worker.1     | Server: f46409e1f5ea, Context: sidekiq, Role: background, data: {cpu: {one_min: 7.28, five_min: 4.39, fifteen_min: 2.9}, memory: 0.233934848e9, disk: {available: 834410500096, total: 938656133120, used: 104245633024}}
2025-10-10T15:31:57.931783449Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.930Z pid=302 tid=hn2 jid=eb87c1d8b1999ec4364f2023 class=Upgrade::GenerateSlugsJob: start
2025-10-10T15:31:57.936219051Z 15:31:57 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [eac01fca-02d7-41e7-bd43-12fd74d78fa2] Performing Upgrade::GenerateSlugsJob (Job ID: eac01fca-02d7-41e7-bd43-12fd74d78fa2) from Sidekiq(high) enqueued at 2025-10-10T15:31:57.554565971Z 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-10T15:31:57.939099701Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.930Z pid=302 tid=hmu jid=0f4c49e495828ec50ea8f27e class=Upgrade::GenerateSlugsJob: start
2025-10-10T15:31:57.961128506Z 15:31:57 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [544985e3-0af9-4e16-8454-d72d6fc9bdde] Performing Upgrade::GenerateSlugsJob (Job ID: 544985e3-0af9-4e16-8454-d72d6fc9bdde) from Sidekiq(high) enqueued at 2025-10-10T15:31:57.558693291Z 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-10T15:31:57.984987586Z 15:31:57 default_worker.1     | INFO  2025-10-10T15:31:57.930Z pid=302 tid=hni jid=a5fc7bc3fabd93e325ab4e4a class=Upgrade::GenerateSlugsJob: start
2025-10-10T15:31:58.017247672Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [49176f53-f93d-4a17-9d47-e7501de92c43] Performing Upgrade::GenerateSlugsJob (Job ID: 49176f53-f93d-4a17-9d47-e7501de92c43) from Sidekiq(high) enqueued at 2025-10-10T15:31:57.561077883Z 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-10T15:31:58.018233326Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:57.930Z pid=302 tid=hna jid=0ea39283798b979a4cf6d0de class=Upgrade::FixNilFileSizeValues: start
2025-10-10T15:31:58.018990772Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [7f6811f0-ad3e-4eec-816f-55d61283a897] Performing Upgrade::FixNilFileSizeValues (Job ID: 7f6811f0-ad3e-4eec-816f-55d61283a897) from Sidekiq(upgrade) enqueued at 2025-10-10T15:31:57.563412163Z
2025-10-10T15:31:58.026250850Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [49176f53-f93d-4a17-9d47-e7501de92c43] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.027365163Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [544985e3-0af9-4e16-8454-d72d6fc9bdde] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.054805855Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [7f6811f0-ad3e-4eec-816f-55d61283a897] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.071949765Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [49176f53-f93d-4a17-9d47-e7501de92c43] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-10T15:31:58.073738186Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [49176f53-f93d-4a17-9d47-e7501de92c43] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.019
2025-10-10T15:31:58.148099713Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [544985e3-0af9-4e16-8454-d72d6fc9bdde] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-10T15:31:58.243555594Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [544985e3-0af9-4e16-8454-d72d6fc9bdde] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.158
2025-10-10T15:31:58.337476523Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [7f6811f0-ad3e-4eec-816f-55d61283a897] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-10T15:31:58.351891889Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [7f6811f0-ad3e-4eec-816f-55d61283a897] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.224
2025-10-10T15:31:58.366407587Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [eac01fca-02d7-41e7-bd43-12fd74d78fa2] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.457422245Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [eac01fca-02d7-41e7-bd43-12fd74d78fa2] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-10T15:31:58.457463137Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [eac01fca-02d7-41e7-bd43-12fd74d78fa2] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.077
2025-10-10T15:31:58.473730361Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [49176f53-f93d-4a17-9d47-e7501de92c43] Performed Upgrade::GenerateSlugsJob (Job ID: 49176f53-f93d-4a17-9d47-e7501de92c43) from Sidekiq(high) in 486.12ms
2025-10-10T15:31:58.477524751Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [544985e3-0af9-4e16-8454-d72d6fc9bdde] Performed Upgrade::GenerateSlugsJob (Job ID: 544985e3-0af9-4e16-8454-d72d6fc9bdde) from Sidekiq(high) in 537.1ms
2025-10-10T15:31:58.478130280Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.477Z pid=302 tid=hni jid=a5fc7bc3fabd93e325ab4e4a class=Upgrade::GenerateSlugsJob elapsed=0.547: done
2025-10-10T15:31:58.478582040Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.478Z pid=302 tid=hmu jid=0f4c49e495828ec50ea8f27e class=Upgrade::GenerateSlugsJob elapsed=0.548: done
2025-10-10T15:31:58.479117348Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [7f6811f0-ad3e-4eec-816f-55d61283a897] Performed Upgrade::FixNilFileSizeValues (Job ID: 7f6811f0-ad3e-4eec-816f-55d61283a897) from Sidekiq(upgrade) in 459.29ms
2025-10-10T15:31:58.479335948Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.478Z pid=302 tid=hni jid=dc24bc6241e0765369b018d1 class=Upgrade::BackfillDataPackages: start
2025-10-10T15:31:58.480787300Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.480Z pid=302 tid=hna jid=0ea39283798b979a4cf6d0de class=Upgrade::FixNilFileSizeValues elapsed=0.55: done
2025-10-10T15:31:58.480896220Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [eac01fca-02d7-41e7-bd43-12fd74d78fa2] Performed Upgrade::GenerateSlugsJob (Job ID: eac01fca-02d7-41e7-bd43-12fd74d78fa2) from Sidekiq(high) in 546.09ms
2025-10-10T15:31:58.481239711Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.479Z pid=302 tid=hmu jid=c46275146ceb8fb83f240168 class=Upgrade::DisambiguateUsernamesJob: start
2025-10-10T15:31:58.487441639Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [0c1cf045-9aba-40b3-a9e7-bc20e44256d6] Performing Upgrade::BackfillDataPackages (Job ID: 0c1cf045-9aba-40b3-a9e7-bc20e44256d6) from Sidekiq(upgrade) enqueued at 2025-10-10T15:31:57.564324910Z
2025-10-10T15:31:58.487811033Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.481Z pid=302 tid=hna jid=1b3047e597ec7873bafbfb46 class=Upgrade::UpdateActorsJob: start
2025-10-10T15:31:58.488887550Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [080adf1a-3304-4a80-bc94-5a4b7672f5d2] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 080adf1a-3304-4a80-bc94-5a4b7672f5d2) from Sidekiq(upgrade) enqueued at 2025-10-10T15:31:57.565231836Z
2025-10-10T15:31:58.489716098Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.486Z pid=302 tid=hn2 jid=eb87c1d8b1999ec4364f2023 class=Upgrade::GenerateSlugsJob elapsed=0.556: done
2025-10-10T15:31:58.490174992Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [5365e991-0e37-4472-8d2b-fdb2f2ea03be] Performing Upgrade::UpdateActorsJob (Job ID: 5365e991-0e37-4472-8d2b-fdb2f2ea03be) from Sidekiq(upgrade) enqueued at 2025-10-10T15:31:57.566037779Z
2025-10-10T15:31:58.493662985Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.493Z pid=302 tid=hn2 jid=7dab0790297b8e68d3eee9a3 class=Upgrade::FixParentCollections: start
2025-10-10T15:31:58.525186378Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [0c1cf045-9aba-40b3-a9e7-bc20e44256d6] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.627883820Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-10-10T15:31:58.629407999Z s6-rc: info: service svc-manyfold successfully started
2025-10-10T15:31:58.629655517Z s6-rc: info: service legacy-services: starting
2025-10-10T15:31:58.640100959Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [080adf1a-3304-4a80-bc94-5a4b7672f5d2] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.640795467Z s6-rc: info: service legacy-services successfully started
2025-10-10T15:31:58.640990390Z s6-rc: info: service ci-service-check: starting
2025-10-10T15:31:58.644178369Z [ls.io-init] done.
2025-10-10T15:31:58.644966205Z s6-rc: info: service ci-service-check successfully started
2025-10-10T15:31:58.712792173Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [52375e32-6f1b-494d-ad57-27151dd422ac] Performing Upgrade::FixParentCollections (Job ID: 52375e32-6f1b-494d-ad57-27151dd422ac) from Sidekiq(upgrade) enqueued at 2025-10-10T15:31:57.566835315Z
2025-10-10T15:31:58.784081644Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [5365e991-0e37-4472-8d2b-fdb2f2ea03be] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.896055224Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [52375e32-6f1b-494d-ad57-27151dd422ac] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:58.917967955Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [0c1cf045-9aba-40b3-a9e7-bc20e44256d6] Performed Upgrade::BackfillDataPackages (Job ID: 0c1cf045-9aba-40b3-a9e7-bc20e44256d6) from Sidekiq(upgrade) in 437.41ms
2025-10-10T15:31:58.921985825Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [080adf1a-3304-4a80-bc94-5a4b7672f5d2] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 080adf1a-3304-4a80-bc94-5a4b7672f5d2) from Sidekiq(upgrade) in 434.55ms
2025-10-10T15:31:58.929326676Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.925Z pid=302 tid=hni jid=dc24bc6241e0765369b018d1 class=Upgrade::BackfillDataPackages elapsed=0.446: done
2025-10-10T15:31:58.945152631Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [5365e991-0e37-4472-8d2b-fdb2f2ea03be] Performed Upgrade::UpdateActorsJob (Job ID: 5365e991-0e37-4472-8d2b-fdb2f2ea03be) from Sidekiq(upgrade) in 440.54ms
2025-10-10T15:31:58.945608659Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [52375e32-6f1b-494d-ad57-27151dd422ac] Performed Upgrade::FixParentCollections (Job ID: 52375e32-6f1b-494d-ad57-27151dd422ac) from Sidekiq(upgrade) in 433.59ms
2025-10-10T15:31:58.955079860Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.944Z pid=302 tid=hmu jid=c46275146ceb8fb83f240168 class=Upgrade::DisambiguateUsernamesJob elapsed=0.466: done
2025-10-10T15:31:58.955183699Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.944Z pid=302 tid=hni jid=60d970862dca881ce4d71d83 class=Upgrade::PruneOrphanedProblems: start
2025-10-10T15:31:58.970679480Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e32e5b82-51f0-4ab7-b6e9-4e8f855a5944] Performing Upgrade::PruneOrphanedProblems (Job ID: e32e5b82-51f0-4ab7-b6e9-4e8f855a5944) from Sidekiq(upgrade) enqueued at 2025-10-10T15:31:57.567758283Z
2025-10-10T15:31:58.972887015Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.954Z pid=302 tid=hna jid=1b3047e597ec7873bafbfb46 class=Upgrade::UpdateActorsJob elapsed=0.474: done
2025-10-10T15:31:58.972926254Z 15:31:58 default_worker.1     | INFO  2025-10-10T15:31:58.959Z pid=302 tid=hn2 jid=7dab0790297b8e68d3eee9a3 class=Upgrade::FixParentCollections elapsed=0.467: done
2025-10-10T15:31:58.974549061Z 15:31:58 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e32e5b82-51f0-4ab7-b6e9-4e8f855a5944] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-10T15:31:59.145343336Z 15:31:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e32e5b82-51f0-4ab7-b6e9-4e8f855a5944] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-10T15:31:59.153693699Z 15:31:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e32e5b82-51f0-4ab7-b6e9-4e8f855a5944] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.163
2025-10-10T15:31:59.177210801Z 15:31:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e32e5b82-51f0-4ab7-b6e9-4e8f855a5944] Performed Upgrade::PruneOrphanedProblems (Job ID: e32e5b82-51f0-4ab7-b6e9-4e8f855a5944) from Sidekiq(upgrade) in 212.38ms
2025-10-10T15:31:59.178888399Z 15:31:59 default_worker.1     | INFO  2025-10-10T15:31:59.177Z pid=302 tid=hni jid=60d970862dca881ce4d71d83 class=Upgrade::PruneOrphanedProblems elapsed=0.233: done
2025-10-10T15:32:27.568939045Z 15:32:27 rails.1              | [8ab37190-af2a-43c7-81b2-a7e42c4d8c50] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1392,"duration":17.46,"view":0.0,"db":2.48,"@timestamp":"2025-10-10T15:32:27.568Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-10T15:32:28.548142665Z 15:32:28 rails.1              | [3aff2bd3-eb16-4ced-beae-20ee864eb339] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":121227,"duration":960.83,"view":0.0,"db":26.82,"location":"http://172.17.0.4:3214/","@timestamp":"2025-10-10T15:32:28.547Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-10T15:32:28.638353355Z 15:32:28 rails.1              | [3a11a3ca-2526-4038-a2bc-78d3b64c3219] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1083,"duration":55.44,"view":0.0,"db":3.39,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-10-10T15:32:28.615Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-10T15:32:29.398139607Z 15:32:29 rails.1              | [44e78322-c14e-42f6-bb74-364a7d6d4e2c] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24040,"duration":726.86,"view":578.55,"db":59.64,"@timestamp":"2025-10-10T15:32:29.397Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-10-10T15:32:29.479406800Z 15:32:29 rails.1              | [75d148cf-cae8-46ed-b82d-fe91bfadc72a] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1179,"duration":33.51,"view":0.0,"db":4.37,"@timestamp":"2025-10-10T15:32:29.477Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-10T15:32:29.782089592Z 15:32:29 rails.1              | [c9dacb6e-8264-471e-97be-69d28217e208] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14490,"duration":225.36,"view":0.0,"db":1.87,"location":"http://172.17.0.4:3214/","@timestamp":"2025-10-10T15:32:29.781Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-10T15:32:29.908714943Z 15:32:29 rails.1              | [74c02713-268c-4968-9b7a-149c165129ef] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1108,"duration":45.93,"view":0.0,"db":4.18,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-10-10T15:32:29.862Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-10T15:32:30.296452724Z 15:32:30 rails.1              | [484bec93-05fd-495f-ac9d-d86a73099743] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24222,"duration":365.03,"view":208.37,"db":1.19,"@timestamp":"2025-10-10T15:32:30.291Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}