2025-10-20T21:18:23.261452600Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-10-20T21:18:23.261489244Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-10-20T21:18:23.318613098Z [mod-init] Running Docker Modification Logic
2025-10-20T21:18:23.551482461Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-10-20T21:18:24.214058387Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-10-20T21:18:24.591397122Z [mod-init] Installing linuxserver/mods:universal-redis
2025-10-20T21:18:24.615037936Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-10-20T21:18:24.616185056Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-10-20T21:18:24.633428190Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-10-20T21:18:24.638120247Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-10-20T21:18:24.638399539Z s6-rc: info: service fix-attrs: starting
2025-10-20T21:18:24.638583389Z s6-rc: info: service init-migrations: starting
2025-10-20T21:18:24.638862812Z s6-rc: info: service init-envfile: starting
2025-10-20T21:18:24.645842463Z s6-rc: info: service fix-attrs successfully started
2025-10-20T21:18:24.645855079Z [migrations] started
2025-10-20T21:18:24.645893156Z [migrations] no migrations found
2025-10-20T21:18:24.645962896Z s6-rc: info: service legacy-cont-init: starting
2025-10-20T21:18:24.646402611Z s6-rc: info: service init-migrations successfully started
2025-10-20T21:18:24.646786474Z s6-rc: info: service init-adduser: starting
2025-10-20T21:18:24.648131552Z s6-rc: info: service init-envfile successfully started
2025-10-20T21:18:24.652651612Z s6-rc: info: service legacy-cont-init successfully started
2025-10-20T21:18:24.678088262Z usermod: no changes
2025-10-20T21:18:24.683810963Z ───────────────────────────────────────
2025-10-20T21:18:24.683823388Z 
2025-10-20T21:18:24.683827396Z       ██╗     ███████╗██╗ ██████╗
2025-10-20T21:18:24.683831364Z       ██║     ██╔════╝██║██╔═══██╗
2025-10-20T21:18:24.683835533Z       ██║     ███████╗██║██║   ██║
2025-10-20T21:18:24.683840032Z       ██║     ╚════██║██║██║   ██║
2025-10-20T21:18:24.683852286Z       ███████╗███████║██║╚██████╔╝
2025-10-20T21:18:24.683858769Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-10-20T21:18:24.683863158Z 
2025-10-20T21:18:24.683866806Z    Brought to you by linuxserver.io
2025-10-20T21:18:24.683880443Z ───────────────────────────────────────
2025-10-20T21:18:24.684208063Z 
2025-10-20T21:18:24.684247662Z To support LSIO projects visit:
2025-10-20T21:18:24.684261650Z https://www.linuxserver.io/donate/
2025-10-20T21:18:24.684274627Z 
2025-10-20T21:18:24.684286851Z ───────────────────────────────────────
2025-10-20T21:18:24.684300529Z GID/UID
2025-10-20T21:18:24.684311050Z ───────────────────────────────────────
2025-10-20T21:18:24.688480805Z 
2025-10-20T21:18:24.688511858Z User UID:    911
2025-10-20T21:18:24.688520655Z User GID:    911
2025-10-20T21:18:24.688528731Z ───────────────────────────────────────
2025-10-20T21:18:24.690133592Z Linuxserver.io version: v0.126.0-ls110
2025-10-20T21:18:24.690367263Z Build-date: 2025-10-20T21:05:58+00:00
2025-10-20T21:18:24.690391652Z ───────────────────────────────────────
2025-10-20T21:18:24.690403887Z     
2025-10-20T21:18:24.709915849Z s6-rc: info: service init-adduser successfully started
2025-10-20T21:18:24.710046041Z s6-rc: info: service init-device-perms: starting
2025-10-20T21:18:24.715396423Z s6-rc: info: service init-device-perms successfully started
2025-10-20T21:18:24.715594922Z s6-rc: info: service init-os-end: starting
2025-10-20T21:18:24.717096515Z s6-rc: info: service init-os-end successfully started
2025-10-20T21:18:24.717273351Z s6-rc: info: service init-manyfold-config: starting
2025-10-20T21:18:24.717388273Z s6-rc: info: service init-config: starting
2025-10-20T21:18:24.718548759Z s6-rc: info: service init-config successfully started
2025-10-20T21:18:24.718665374Z s6-rc: info: service init-crontab-config: starting
2025-10-20T21:18:24.721474589Z **** SECRET_KEY_BASE set in environment. ****
2025-10-20T21:18:24.730579550Z s6-rc: info: service init-crontab-config successfully started
2025-10-20T21:18:24.744888748Z **** Running Manyfold database init. ****
2025-10-20T21:18:27.037606347Z `/root` is not writable.
2025-10-20T21:18:27.037829927Z Bundler will use `/tmp/bundler20251020-173-72q1uo173' as your home directory temporarily.
2025-10-20T21:18:33.971135515Z Server: 7efd1ffbaf0c, Context: rails, Role: web, data: {cpu: {one_min: 1.81, five_min: 1.46, fifteen_min: 3.08}, memory: 0.236109824e9, disk: {available: 833488412672, total: 938656133120, used: 105167720448}}
2025-10-20T21:18:33.971165997Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-10-20T21:18:33.971170927Z INFO  2025-10-20T21:18:32.195Z pid=173 tid=2id: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-20T21:18:33.971196458Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.default_viewer_role` fallback to returns the default value.
2025-10-20T21:18:33.971200607Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-10-20T21:18:33.971204725Z Migrating to CreateLibraries (20210130201037)
2025-10-20T21:18:33.971208542Z == 20210130201037 CreateLibraries: migrating ==================================
2025-10-20T21:18:33.971212180Z -- create_table(:libraries)
2025-10-20T21:18:33.971216068Z    -> 0.0027s
2025-10-20T21:18:33.971220016Z == 20210130201037 CreateLibraries: migrated (0.0028s) =========================
2025-10-20T21:18:33.971223883Z 
2025-10-20T21:18:33.971227461Z Migrating to CreateModels (20210130203243)
2025-10-20T21:18:33.971231318Z == 20210130203243 CreateModels: migrating =====================================
2025-10-20T21:18:33.971235076Z -- create_table(:models)
2025-10-20T21:18:33.971238823Z    -> 0.0009s
2025-10-20T21:18:33.971242531Z == 20210130203243 CreateModels: migrated (0.0009s) ============================
2025-10-20T21:18:33.971246218Z 
2025-10-20T21:18:33.971249745Z Migrating to CreateParts (20210205230918)
2025-10-20T21:18:33.971253713Z == 20210205230918 CreateParts: migrating ======================================
2025-10-20T21:18:33.971257271Z -- create_table(:parts)
2025-10-20T21:18:33.971260848Z    -> 0.0034s
2025-10-20T21:18:33.971264986Z == 20210205230918 CreateParts: migrated (0.0034s) =============================
2025-10-20T21:18:33.971268563Z 
2025-10-20T21:18:33.971272090Z Migrating to AddFieldsToParts (20210210153744)
2025-10-20T21:18:33.971275858Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-10-20T21:18:33.971279756Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-10-20T21:18:33.971283964Z    -> 0.0007s
2025-10-20T21:18:33.971287702Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-10-20T21:18:33.971291510Z    -> 0.0003s
2025-10-20T21:18:33.971295067Z == 20210210153744 AddFieldsToParts: migrated (0.0011s) ========================
2025-10-20T21:18:33.971298884Z 
2025-10-20T21:18:33.971302542Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-10-20T21:18:33.971306079Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-10-20T21:18:33.971309726Z -- create_table(:tags, {id: :integer})
2025-10-20T21:18:33.971313905Z    -> 0.0037s
2025-10-20T21:18:33.971318664Z -- create_table(:taggings, {id: :integer})
2025-10-20T21:18:33.971328093Z    -> 0.0017s
2025-10-20T21:18:33.971331771Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-20T21:18:33.971335779Z    -> 0.0002s
2025-10-20T21:18:33.971341480Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-20T21:18:33.971345679Z    -> 0.0021s
2025-10-20T21:18:33.971349306Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0078s) ===============
2025-10-20T21:18:33.971353264Z 
2025-10-20T21:18:33.971357092Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-10-20T21:18:33.971360899Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-10-20T21:18:33.971365228Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-10-20T21:18:33.971369426Z    -> 0.0003s
2025-10-20T21:18:33.971373254Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-20T21:18:33.971376921Z    -> 0.0004s
2025-10-20T21:18:33.971380639Z -- remove_foreign_key(:taggings, :tags)
2025-10-20T21:18:33.971384407Z    -> 0.1657s
2025-10-20T21:18:33.971388114Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-20T21:18:33.971392012Z    -> 0.0147s
2025-10-20T21:18:33.971395830Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-10-20T21:18:33.971399808Z    -> 0.0002s
2025-10-20T21:18:33.971403545Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-10-20T21:18:33.971407563Z    -> 0.0045s
2025-10-20T21:18:33.971411180Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-10-20T21:18:33.971415098Z    -> 0.0701s
2025-10-20T21:18:33.971418776Z == 20210212143002 AddMissingUniqueIndices: migrated (0.2863s) =================
2025-10-20T21:18:33.971422473Z 
2025-10-20T21:18:33.971426141Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-10-20T21:18:33.971430299Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-10-20T21:18:33.971434257Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-10-20T21:18:33.971437974Z    -> 0.0342s
2025-10-20T21:18:33.971442153Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1134s) ===========
2025-10-20T21:18:33.971446041Z 
2025-10-20T21:18:33.971449758Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-10-20T21:18:33.971453726Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-10-20T21:18:33.971457464Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-20T21:18:33.971493957Z    -> 0.0003s
2025-10-20T21:18:33.971497655Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-10-20T21:18:33.971501993Z 
2025-10-20T21:18:33.971505711Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-10-20T21:18:33.971510681Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-10-20T21:18:33.971514368Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0007s) ==============
2025-10-20T21:18:33.971518336Z 
2025-10-20T21:18:33.971522505Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-10-20T21:18:33.971526122Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-10-20T21:18:33.971529940Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-20T21:18:33.971533687Z    -> 0.0073s
2025-10-20T21:18:33.971537815Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-20T21:18:33.971541823Z    -> 0.0002s
2025-10-20T21:18:33.971545641Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-20T21:18:33.971549339Z    -> 0.0057s
2025-10-20T21:18:33.971552866Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-20T21:18:33.971556573Z    -> 0.0012s
2025-10-20T21:18:33.971560040Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-20T21:18:33.971563667Z    -> 0.0004s
2025-10-20T21:18:33.971567435Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-20T21:18:33.971571153Z    -> 0.0001s
2025-10-20T21:18:33.971574589Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-20T21:18:33.971578347Z    -> 0.0038s
2025-10-20T21:18:33.971581904Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-20T21:18:33.971585511Z    -> 0.0001s
2025-10-20T21:18:33.971589039Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-20T21:18:33.971592806Z    -> 0.0006s
2025-10-20T21:18:33.971596243Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-20T21:18:33.971599840Z    -> 0.0001s
2025-10-20T21:18:33.971603488Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-20T21:18:33.971607375Z    -> 0.0006s
2025-10-20T21:18:33.971610832Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-20T21:18:33.971614520Z    -> 0.0001s
2025-10-20T21:18:33.971622636Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-20T21:18:33.971626304Z    -> 0.0015s
2025-10-20T21:18:33.971629781Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-20T21:18:33.971633859Z    -> 0.0002s
2025-10-20T21:18:33.971637426Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0223s) =============
2025-10-20T21:18:33.971640973Z 
2025-10-20T21:18:33.971644530Z Migrating to AddPreviewPartToModel (20210220204055)
2025-10-20T21:18:33.971648148Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-10-20T21:18:33.971651675Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-10-20T21:18:33.971655342Z    -> 0.2419s
2025-10-20T21:18:33.971658989Z == 20210220204055 AddPreviewPartToModel: migrated (0.2419s) ===================
2025-10-20T21:18:33.971663148Z 
2025-10-20T21:18:33.971666825Z Migrating to CreateCreators (20210225232756)
2025-10-20T21:18:33.971670523Z == 20210225232756 CreateCreators: migrating ===================================
2025-10-20T21:18:33.971674340Z -- create_table(:creators)
2025-10-20T21:18:33.971677948Z    -> 0.0137s
2025-10-20T21:18:33.971681595Z == 20210225232756 CreateCreators: migrated (0.0138s) ==========================
2025-10-20T21:18:33.971685232Z 
2025-10-20T21:18:33.971688699Z Migrating to AddCreatorToModels (20210225232841)
2025-10-20T21:18:33.971692797Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-10-20T21:18:33.971696445Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-10-20T21:18:33.971700423Z    -> 0.0501s
2025-10-20T21:18:33.971704070Z == 20210225232841 AddCreatorToModels: migrated (0.0502s) ======================
2025-10-20T21:18:33.971707848Z 
2025-10-20T21:18:33.971711856Z Migrating to CreateLinks (20210301230017)
2025-10-20T21:18:33.971715533Z == 20210301230017 CreateLinks: migrating ======================================
2025-10-20T21:18:33.971719070Z -- create_table(:links)
2025-10-20T21:18:33.971723108Z    -> 0.0008s
2025-10-20T21:18:33.971726846Z == 20210301230017 CreateLinks: migrated (0.0009s) =============================
2025-10-20T21:18:33.971730453Z 
2025-10-20T21:18:33.971733930Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-10-20T21:18:33.971737598Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-10-20T21:18:33.971741315Z -- remove_column(:creators, :thingiverse_user, :string)
2025-10-20T21:18:33.971744822Z    -> 0.0668s
2025-10-20T21:18:33.971748349Z -- remove_column(:creators, :cults3d_user, :string)
2025-10-20T21:18:33.971756516Z    -> 0.0040s
2025-10-20T21:18:33.971760604Z -- remove_column(:creators, :mmf_user, :string)
2025-10-20T21:18:33.971764402Z    -> 0.0135s
2025-10-20T21:18:33.971767869Z -- remove_column(:creators, :cgtrader_user, :string)
2025-10-20T21:18:33.971771536Z    -> 0.0038s
2025-10-20T21:18:33.971775193Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0903s) ==============
2025-10-20T21:18:33.971778811Z 
2025-10-20T21:18:33.971782398Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-10-20T21:18:33.971786196Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-10-20T21:18:33.971789773Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-10-20T21:18:33.971793380Z    -> 0.0635s
2025-10-20T21:18:33.971797077Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0635s) ==
2025-10-20T21:18:33.971800735Z 
2025-10-20T21:18:33.971804212Z Migrating to AddYUpToParts (20210318202638)
2025-10-20T21:18:33.971807879Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-10-20T21:18:33.971811446Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-10-20T21:18:33.971815104Z    -> 0.0167s
2025-10-20T21:18:33.971818992Z == 20210318202638 AddYUpToParts: migrated (0.0168s) ===========================
2025-10-20T21:18:33.971822719Z 
2025-10-20T21:18:33.971826316Z Migrating to CreateImages (20210321164508)
2025-10-20T21:18:33.971829904Z == 20210321164508 CreateImages: migrating =====================================
2025-10-20T21:18:33.971833541Z -- create_table(:images)
2025-10-20T21:18:33.971837198Z    -> 0.0178s
2025-10-20T21:18:33.971841286Z == 20210321164508 CreateImages: migrated (0.0178s) ============================
2025-10-20T21:18:33.971854042Z 
2025-10-20T21:18:33.971858862Z Migrating to CreateDelayedJobs (20210330215825)
2025-10-20T21:18:34.715487188Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-10-20T21:18:34.715524062Z -- create_table(:delayed_jobs)
2025-10-20T21:18:34.715533651Z    -> 0.0093s
2025-10-20T21:18:34.715542449Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-10-20T21:18:34.715551357Z    -> 0.0002s
2025-10-20T21:18:34.715560255Z == 20210330215825 CreateDelayedJobs: migrated (0.0096s) =======================
2025-10-20T21:18:34.715569032Z 
2025-10-20T21:18:34.715577439Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-10-20T21:18:34.715586407Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-10-20T21:18:34.715827823Z -- rename_table(:parts, :model_files)
2025-10-20T21:18:34.715837503Z    -> 0.0018s
2025-10-20T21:18:34.715862623Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-10-20T21:18:34.715873505Z    -> 0.0355s
2025-10-20T21:18:34.715881712Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0374s) =================
2025-10-20T21:18:34.715889848Z 
2025-10-20T21:18:34.715897604Z Migrating to RemoveImagesTable (20220106220519)
2025-10-20T21:18:34.715905600Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-10-20T21:18:34.715913786Z -- drop_table(:images)
2025-10-20T21:18:34.715921763Z    -> 0.0004s
2025-10-20T21:18:34.715929658Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-10-20T21:18:34.715937775Z 
2025-10-20T21:18:34.715945621Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-10-20T21:18:34.715953667Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-10-20T21:18:34.715961743Z -- table_exists?(:active_storage_blobs)
2025-10-20T21:18:34.715969699Z    -> 0.0001s
2025-10-20T21:18:34.715977595Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0002s) ======
2025-10-20T21:18:34.715985751Z 
2025-10-20T21:18:34.715995952Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-10-20T21:18:34.716004018Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-10-20T21:18:34.716012495Z -- table_exists?(:active_storage_blobs)
2025-10-20T21:18:34.716020441Z    -> 0.0001s
2025-10-20T21:18:34.716028327Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0002s) =======
2025-10-20T21:18:34.716036463Z 
2025-10-20T21:18:34.716044189Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-10-20T21:18:34.716052265Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-10-20T21:18:34.716060342Z -- table_exists?(:active_storage_blobs)
2025-10-20T21:18:34.716068308Z    -> 0.0001s
2025-10-20T21:18:34.716076274Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0002s) 
2025-10-20T21:18:34.716084430Z 
2025-10-20T21:18:34.716092226Z Migrating to DeviseCreateUsers (20220614210023)
2025-10-20T21:18:34.716100452Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-10-20T21:18:34.716108999Z -- create_table(:users)
2025-10-20T21:18:34.716116915Z    -> 0.0012s
2025-10-20T21:18:34.716124841Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-10-20T21:18:34.716133469Z    -> 0.0016s
2025-10-20T21:18:34.716151896Z == 20220614210023 DeviseCreateUsers: migrated (0.0029s) =======================
2025-10-20T21:18:34.716160022Z 
2025-10-20T21:18:34.716168139Z Migrating to AddUsernameToUsers (20220614211256)
2025-10-20T21:18:34.716177588Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-10-20T21:18:34.716185804Z -- add_column(:users, :username, :string, {null: false})
2025-10-20T21:18:34.716193900Z    -> 0.0643s
2025-10-20T21:18:34.716202127Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-10-20T21:18:34.716210333Z    -> 0.0002s
2025-10-20T21:18:34.716218510Z == 20220614211256 AddUsernameToUsers: migrated (0.0646s) ======================
2025-10-20T21:18:34.716226676Z 
2025-10-20T21:18:34.716234693Z Migrating to AddAdminToUsers (20220614213902)
2025-10-20T21:18:34.716243029Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-10-20T21:18:34.716251236Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-20T21:18:34.716259713Z    -> 0.0006s
2025-10-20T21:18:34.716267629Z == 20220614213902 AddAdminToUsers: migrated (0.0006s) =========================
2025-10-20T21:18:34.716275695Z 
2025-10-20T21:18:34.716283801Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-10-20T21:18:34.716292048Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-10-20T21:18:34.716300435Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-10-20T21:18:34.716309894Z    -> 0.0012s
2025-10-20T21:18:34.716317870Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0012s) =============
2025-10-20T21:18:34.716326217Z 
2025-10-20T21:18:34.716335335Z Migrating to CreateSettings (20220619174307)
2025-10-20T21:18:34.716343381Z == 20220619174307 CreateSettings: migrating ===================================
2025-10-20T21:18:34.716351578Z -- create_table(:settings)
2025-10-20T21:18:34.716359524Z    -> 0.0029s
2025-10-20T21:18:34.716367450Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-10-20T21:18:34.716375716Z    -> 0.0002s
2025-10-20T21:18:34.716383602Z == 20220619174307 CreateSettings: migrated (0.0032s) ==========================
2025-10-20T21:18:34.716391689Z 
2025-10-20T21:18:34.716399675Z Migrating to AddScaleFactorToModels (20220626152444)
2025-10-20T21:18:34.716407671Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-10-20T21:18:34.716416018Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-10-20T21:18:34.716424114Z    -> 0.0115s
2025-10-20T21:18:34.716441439Z == 20220626152444 AddScaleFactorToModels: migrated (0.0141s) ==================
2025-10-20T21:18:34.716449675Z 
2025-10-20T21:18:34.716457511Z Migrating to AddDigestToModelFiles (20220702202932)
2025-10-20T21:18:34.716465607Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-10-20T21:18:34.716474044Z -- add_column(:model_files, :digest, :string)
2025-10-20T21:18:34.716482521Z    -> 0.0025s
2025-10-20T21:18:34.716490968Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-10-20T21:18:34.716500087Z    -> 0.0002s
2025-10-20T21:18:34.716508363Z == 20220702202932 AddDigestToModelFiles: migrated (0.0047s) ===================
2025-10-20T21:18:34.716516710Z 
2025-10-20T21:18:34.716525378Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-10-20T21:18:34.716533654Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-10-20T21:18:34.716542121Z -- 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-20T21:18:34.716554526Z    -> 0.0009s
2025-10-20T21:18:34.716562793Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0012s) ==============
2025-10-20T21:18:34.716571130Z 
2025-10-20T21:18:34.716579417Z Migrating to CreateProblems (20221210001132)
2025-10-20T21:18:34.716587663Z == 20221210001132 CreateProblems: migrating ===================================
2025-10-20T21:18:34.716596150Z -- create_table(:problems)
2025-10-20T21:18:34.716604196Z    -> 0.0009s
2025-10-20T21:18:34.716612283Z == 20221210001132 CreateProblems: migrated (0.0013s) ==========================
2025-10-20T21:18:34.716620740Z 
2025-10-20T21:18:34.716629447Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-10-20T21:18:34.716639277Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-10-20T21:18:34.716647544Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0159s) ========
2025-10-20T21:18:34.716655700Z 
2025-10-20T21:18:34.716663796Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-10-20T21:18:34.716671802Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-10-20T21:18:34.716680169Z -- create_table(:favorites, {force: true})
2025-10-20T21:18:34.716688155Z    -> 0.0039s
2025-10-20T21:18:34.716697244Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-10-20T21:18:34.716705821Z    -> 0.0010s
2025-10-20T21:18:34.716713797Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-10-20T21:18:34.716731843Z    -> 0.0001s
2025-10-20T21:18:34.716740090Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-10-20T21:18:34.716749679Z    -> 0.0001s
2025-10-20T21:18:34.716757635Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0056s) ================
2025-10-20T21:18:34.716766243Z 
2025-10-20T21:18:34.716774209Z Migrating to MovePrintedToFavorites (20221220223040)
2025-10-20T21:18:34.716782235Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-10-20T21:18:34.716790351Z == 20221220223040 MovePrintedToFavorites: migrated (0.0617s) ==================
2025-10-20T21:18:34.716798417Z 
2025-10-20T21:18:34.716806173Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-10-20T21:18:34.716814289Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-10-20T21:18:34.716822386Z -- remove_column(:model_files, :printed, :boolean)
2025-10-20T21:18:34.716830442Z    -> 0.0250s
2025-10-20T21:18:34.716839230Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0254s) ===============
2025-10-20T21:18:34.716847687Z 
2025-10-20T21:18:34.716855502Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-10-20T21:18:34.716863549Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-10-20T21:18:34.716872036Z -- add_column(:models, :notes, :text)
2025-10-20T21:18:34.716879992Z    -> 0.0011s
2025-10-20T21:18:34.716887958Z -- add_column(:models, :excerpt, :text)
2025-10-20T21:18:34.716896204Z    -> 0.0021s
2025-10-20T21:18:34.716904200Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0033s) =================
2025-10-20T21:18:34.716912447Z 
2025-10-20T21:18:34.716920223Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-10-20T21:18:34.716928219Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-10-20T21:18:34.716936295Z -- add_column(:creators, :notes, :text)
2025-10-20T21:18:34.716944271Z    -> 0.0008s
2025-10-20T21:18:34.716952217Z -- add_column(:creators, :excerpt, :text)
2025-10-20T21:18:34.716960414Z    -> 0.0005s
2025-10-20T21:18:34.716968560Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0013s) ===============
2025-10-20T21:18:34.716976947Z 
2025-10-20T21:18:34.716984933Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-10-20T21:18:34.716992949Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-10-20T21:18:34.717001045Z -- add_column(:model_files, :notes, :text)
2025-10-20T21:18:34.717019673Z    -> 0.0005s
2025-10-20T21:18:34.717027659Z -- add_column(:model_files, :excerpt, :text)
2025-10-20T21:18:34.717035675Z    -> 0.0005s
2025-10-20T21:18:34.717043882Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0010s) =============
2025-10-20T21:18:34.717051958Z 
2025-10-20T21:18:34.717059854Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-10-20T21:18:34.717068331Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-10-20T21:18:34.717076658Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0198s) =================
2025-10-20T21:18:34.717084944Z 
2025-10-20T21:18:34.717092870Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-10-20T21:18:34.717101087Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-10-20T21:18:34.717109383Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-10-20T21:18:34.717117830Z    -> 0.0418s
2025-10-20T21:18:34.717125756Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0418s) =============
2025-10-20T21:18:34.717133893Z 
2025-10-20T21:18:34.717142981Z Migrating to RenameExcerptToCaption (20230222155910)
2025-10-20T21:18:34.717151498Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-10-20T21:18:34.717159935Z -- rename_column(:creators, :excerpt, :caption)
2025-10-20T21:18:34.717167961Z    -> 0.0210s
2025-10-20T21:18:34.717176258Z -- rename_column(:models, :excerpt, :caption)
2025-10-20T21:18:34.717184314Z    -> 0.0201s
2025-10-20T21:18:34.717192270Z -- rename_column(:model_files, :excerpt, :caption)
2025-10-20T21:18:34.717200327Z    -> 0.0192s
2025-10-20T21:18:34.717208834Z == 20230222155910 RenameExcerptToCaption: migrated (0.0627s) ==================
2025-10-20T21:18:34.717216940Z 
2025-10-20T21:18:34.717224776Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-10-20T21:18:35.197093379Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-10-20T21:18:35.197131636Z -- add_column(:libraries, :notes, :string)
2025-10-20T21:18:35.197143510Z    -> 0.0020s
2025-10-20T21:18:35.197152919Z -- add_column(:libraries, :caption, :string)
2025-10-20T21:18:35.197161516Z    -> 0.0004s
2025-10-20T21:18:35.197170254Z -- add_column(:libraries, :name, :string)
2025-10-20T21:18:35.197178550Z    -> 0.0004s
2025-10-20T21:18:35.197186847Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0113s) ============
2025-10-20T21:18:35.197195635Z 
2025-10-20T21:18:35.197203841Z Migrating to AddTagregexToLibrary (20230305180823)
2025-10-20T21:18:35.197246357Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-10-20T21:18:35.197254744Z -- add_column(:libraries, :tag_regex, :text)
2025-10-20T21:18:35.197262720Z    -> 0.0019s
2025-10-20T21:18:35.197270646Z == 20230305180823 AddTagregexToLibrary: migrated (0.0034s) ====================
2025-10-20T21:18:35.197279263Z 
2025-10-20T21:18:35.197286919Z Migrating to AddIconToLibrary (20230307215826)
2025-10-20T21:18:35.197295175Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-10-20T21:18:35.197303532Z -- add_column(:libraries, :icon, :text)
2025-10-20T21:18:35.197311378Z    -> 0.0017s
2025-10-20T21:18:35.197319625Z == 20230307215826 AddIconToLibrary: migrated (0.0032s) ========================
2025-10-20T21:18:35.197328222Z 
2025-10-20T21:18:35.197335927Z Migrating to CreateCollection (20230308004237)
2025-10-20T21:18:35.197343813Z == 20230308004237 CreateCollection: migrating =================================
2025-10-20T21:18:35.197351970Z -- create_table(:collections)
2025-10-20T21:18:35.197359996Z    -> 0.0026s
2025-10-20T21:18:35.197368343Z == 20230308004237 CreateCollection: migrated (0.0064s) ========================
2025-10-20T21:18:35.197376399Z 
2025-10-20T21:18:35.197384335Z Migrating to AddCollectionToModels (20230308005021)
2025-10-20T21:18:35.197392171Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-10-20T21:18:35.197400317Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-10-20T21:18:35.197408223Z    -> 0.0172s
2025-10-20T21:18:35.197416059Z == 20230308005021 AddCollectionToModels: migrated (0.0206s) ===================
2025-10-20T21:18:35.197424415Z 
2025-10-20T21:18:35.197432031Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-10-20T21:18:35.197439927Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-10-20T21:18:35.197447913Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0014s) =============
2025-10-20T21:18:35.197455899Z 
2025-10-20T21:18:35.197463524Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-10-20T21:18:35.197471400Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-10-20T21:18:35.197479376Z -- rename_column(:collections, :excerpt, :caption)
2025-10-20T21:18:35.197487452Z    -> 0.0040s
2025-10-20T21:18:35.197495188Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0040s) ========
2025-10-20T21:18:35.197503164Z 
2025-10-20T21:18:35.197510769Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-10-20T21:18:35.197518605Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-10-20T21:18:35.197539217Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-10-20T21:18:35.197547383Z 
2025-10-20T21:18:35.197554988Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-10-20T21:18:35.197563135Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-10-20T21:18:35.197571121Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-10-20T21:18:35.197580600Z    -> 0.0018s
2025-10-20T21:18:35.197588796Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0019s) ===============
2025-10-20T21:18:35.197596863Z 
2025-10-20T21:18:35.197604588Z Migrating to AddCollectionToCollections (20230324000000)
2025-10-20T21:18:35.197612444Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-10-20T21:18:35.197620801Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-10-20T21:18:35.197629238Z    -> 0.0061s
2025-10-20T21:18:35.197637514Z == 20230324000000 AddCollectionToCollections: migrated (0.0082s) ==============
2025-10-20T21:18:35.197645631Z 
2025-10-20T21:18:35.197653236Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-10-20T21:18:35.197661102Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-10-20T21:18:35.197668998Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0466s) =========
2025-10-20T21:18:35.197677044Z 
2025-10-20T21:18:35.197684830Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-10-20T21:18:35.197693106Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-10-20T21:18:35.197701233Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0070s) 
2025-10-20T21:18:35.197709249Z 
2025-10-20T21:18:35.197717145Z Migrating to AddSlugs (20230615135601)
2025-10-20T21:18:35.197725191Z == 20230615135601 AddSlugs: migrating =========================================
2025-10-20T21:18:35.197733387Z -- add_column(:models, :slug, :string)
2025-10-20T21:18:35.197741624Z    -> 0.0027s
2025-10-20T21:18:35.197749901Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-10-20T21:18:35.197758648Z    -> 0.0019s
2025-10-20T21:18:35.197767286Z -- add_column(:collections, :slug, :string)
2025-10-20T21:18:35.197775823Z    -> 0.0005s
2025-10-20T21:18:35.197783739Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-10-20T21:18:35.197792056Z    -> 0.0001s
2025-10-20T21:18:35.197800012Z -- add_column(:creators, :slug, :string)
2025-10-20T21:18:35.197817717Z    -> 0.0005s
2025-10-20T21:18:35.197825904Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-10-20T21:18:35.197834060Z    -> 0.0001s
2025-10-20T21:18:35.197842267Z == 20230615135601 AddSlugs: migrated (0.0064s) ================================
2025-10-20T21:18:35.197850393Z 
2025-10-20T21:18:35.197858499Z Migrating to GenerateSlugs (20230617222353)
2025-10-20T21:18:35.197866526Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-10-20T21:18:35.197874401Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-10-20T21:18:35.197882307Z 
2025-10-20T21:18:35.197889943Z Migrating to MakeNamesUnique (20230628194944)
2025-10-20T21:18:35.197899993Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-10-20T21:18:35.197908029Z == 20230628194944 MakeNamesUnique: migrated (0.0031s) =========================
2025-10-20T21:18:35.197915985Z 
2025-10-20T21:18:35.197923580Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-10-20T21:18:35.197931647Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-10-20T21:18:35.197939533Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-10-20T21:18:35.197947539Z    -> 0.0020s
2025-10-20T21:18:35.197955364Z -- remove_index(:creators, :slug)
2025-10-20T21:18:35.197963280Z    -> 0.0004s
2025-10-20T21:18:35.197971056Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-10-20T21:18:35.197979132Z    -> 0.0001s
2025-10-20T21:18:35.197987068Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-10-20T21:18:35.197995215Z    -> 0.0001s
2025-10-20T21:18:35.198003030Z -- remove_index(:collections, :slug)
2025-10-20T21:18:35.198010876Z    -> 0.0230s
2025-10-20T21:18:35.198018702Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-10-20T21:18:35.198026868Z    -> 0.0005s
2025-10-20T21:18:35.198034634Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0267s) ======
2025-10-20T21:18:35.198042600Z 
2025-10-20T21:18:35.198050235Z Migrating to AddSizeToModelFiles (20230707082403)
2025-10-20T21:18:35.198058031Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-10-20T21:18:35.198066328Z -- add_column(:model_files, :size, :integer)
2025-10-20T21:18:35.198074093Z    -> 0.0006s
2025-10-20T21:18:35.198081919Z == 20230707082403 AddSizeToModelFiles: migrated (0.0010s) =====================
2025-10-20T21:18:35.198090166Z 
2025-10-20T21:18:35.198107350Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-10-20T21:18:35.198115206Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-10-20T21:18:35.198123142Z -- change_column(:model_files, :size, :bigint)
2025-10-20T21:18:35.198131449Z    -> 0.0088s
2025-10-20T21:18:35.198139215Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0091s) ==================
2025-10-20T21:18:35.198147221Z 
2025-10-20T21:18:35.198154866Z Migrating to AddNoteToProblems (20230711111009)
2025-10-20T21:18:35.198163944Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-10-20T21:18:35.198172461Z -- add_column(:problems, :note, :string, {default: nil})
2025-10-20T21:18:35.198180608Z    -> 0.0012s
2025-10-20T21:18:35.198188594Z == 20230711111009 AddNoteToProblems: migrated (0.0022s) =======================
2025-10-20T21:18:35.198196570Z 
2025-10-20T21:18:35.198204185Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-10-20T21:18:35.198212061Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-10-20T21:18:35.198221119Z -- 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-20T21:18:35.198236340Z    -> 0.0010s
2025-10-20T21:18:35.198244286Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0010s) ================
2025-10-20T21:18:35.198252272Z 
2025-10-20T21:18:35.198259938Z Migrating to AddLicenseToModel (20240127143358)
2025-10-20T21:18:35.198267773Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-10-20T21:18:35.198275729Z -- add_column(:models, :license, :string)
2025-10-20T21:18:35.198283806Z    -> 0.0006s
2025-10-20T21:18:35.198291792Z == 20240127143358 AddLicenseToModel: migrated (0.0007s) =======================
2025-10-20T21:18:35.198300108Z 
2025-10-20T21:18:35.198307974Z Migrating to AddIgnoredToProblems (20240131134832)
2025-10-20T21:18:35.198315840Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-10-20T21:18:35.198324067Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-10-20T21:18:35.198332343Z    -> 0.0007s
2025-10-20T21:18:35.198340329Z == 20240131134832 AddIgnoredToProblems: migrated (0.0008s) ====================
2025-10-20T21:18:35.198348546Z 
2025-10-20T21:18:35.198356783Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-10-20T21:18:35.198386502Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-10-20T21:18:35.198394549Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-10-20T21:18:35.198403096Z    -> 0.0115s
2025-10-20T21:18:35.198410891Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0115s) ======
2025-10-20T21:18:35.198418827Z 
2025-10-20T21:18:35.198426463Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-10-20T21:18:35.198434920Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-10-20T21:18:35.198443217Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-10-20T21:18:35.198451643Z    -> 0.0007s
2025-10-20T21:18:35.198459720Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0008s) ===============
2025-10-20T21:18:35.198467726Z 
2025-10-20T21:18:35.198475321Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-10-20T21:18:35.198483698Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-10-20T21:18:35.198492466Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-10-20T21:18:35.198500973Z    -> 0.0003s
2025-10-20T21:18:35.198508969Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-10-20T21:18:35.198518067Z    -> 0.0009s
2025-10-20T21:18:35.198525913Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-10-20T21:18:35.198534160Z    -> 0.0001s
2025-10-20T21:18:35.858023644Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-10-20T21:18:35.858070698Z    -> 0.0043s
2025-10-20T21:18:35.858080328Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0057s) =================
2025-10-20T21:18:35.858089126Z 
2025-10-20T21:18:35.858097242Z Migrating to CreateFlipperTables (20240306095646)
2025-10-20T21:18:35.858105238Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-10-20T21:18:35.858113274Z -- create_table(:flipper_features)
2025-10-20T21:18:35.858121090Z    -> 0.0027s
2025-10-20T21:18:35.858128986Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-10-20T21:18:35.858137212Z    -> 0.0047s
2025-10-20T21:18:35.858145369Z -- create_table(:flipper_gates)
2025-10-20T21:18:35.858153174Z    -> 0.0003s
2025-10-20T21:18:35.858161241Z -- 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-20T21:18:35.858183716Z    -> 0.0001s
2025-10-20T21:18:35.858191652Z == 20240306095646 CreateFlipperTables: migrated (0.0079s) =====================
2025-10-20T21:18:35.858199598Z 
2025-10-20T21:18:35.858207213Z Migrating to RolifyCreateRoles (20240319155251)
2025-10-20T21:18:35.858215340Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-10-20T21:18:35.858223536Z -- create_table(:roles)
2025-10-20T21:18:35.858231242Z    -> 0.0429s
2025-10-20T21:18:35.858239518Z -- create_table(:users_roles, {id: false})
2025-10-20T21:18:35.858247384Z    -> 0.0006s
2025-10-20T21:18:35.858255160Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-10-20T21:18:35.858263216Z    -> 0.0046s
2025-10-20T21:18:35.858270982Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-10-20T21:18:35.858279459Z    -> 0.0002s
2025-10-20T21:18:35.858287204Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-10-20T21:18:35.858295321Z    -> 0.0001s
2025-10-20T21:18:35.858303367Z == 20240319155251 RolifyCreateRoles: migrated (0.0635s) =======================
2025-10-20T21:18:35.858311503Z 
2025-10-20T21:18:35.858319109Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-10-20T21:18:35.858327195Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-10-20T21:18:35.858335391Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0075s) ==================
2025-10-20T21:18:35.858343458Z 
2025-10-20T21:18:35.858351203Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-10-20T21:18:35.858359530Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-10-20T21:18:35.858367847Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-20T21:18:35.858376143Z    -> 0.0232s
2025-10-20T21:18:35.858383989Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0245s) ====================
2025-10-20T21:18:35.858392035Z 
2025-10-20T21:18:35.858399751Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-10-20T21:18:35.858408048Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-10-20T21:18:35.858416114Z -- add_column(:users, :reset_password_token, :string)
2025-10-20T21:18:35.858424170Z    -> 0.0011s
2025-10-20T21:18:35.858434080Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-10-20T21:18:35.858442757Z    -> 0.0001s
2025-10-20T21:18:35.858450754Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0030s) ============
2025-10-20T21:18:35.858468840Z 
2025-10-20T21:18:35.858476535Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-10-20T21:18:35.858484582Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-10-20T21:18:35.858492708Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0237s) ==============
2025-10-20T21:18:35.858500854Z 
2025-10-20T21:18:35.858508760Z Migrating to AddRememberableToUsers (20240410221112)
2025-10-20T21:18:35.858516616Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-10-20T21:18:35.858524783Z -- add_column(:users, :remember_created_at, :datetime)
2025-10-20T21:18:35.858532819Z    -> 0.0030s
2025-10-20T21:18:35.858540554Z == 20240410221112 AddRememberableToUsers: migrated (0.0041s) ==================
2025-10-20T21:18:35.858548440Z 
2025-10-20T21:18:35.858556436Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-10-20T21:18:35.858564523Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-10-20T21:18:35.858572499Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-10-20T21:18:35.858580354Z    -> 0.0006s
2025-10-20T21:18:35.858588100Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0017s) ===========
2025-10-20T21:18:35.858596076Z 
2025-10-20T21:18:35.858603661Z Migrating to DropDelayedJobs (20240418112821)
2025-10-20T21:18:35.858611447Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-10-20T21:18:35.858619373Z -- drop_table(:delayed_jobs)
2025-10-20T21:18:35.858627119Z    -> 0.0018s
2025-10-20T21:18:35.858634884Z == 20240418112821 DropDelayedJobs: migrated (0.0128s) =========================
2025-10-20T21:18:35.858642800Z 
2025-10-20T21:18:35.858650395Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-10-20T21:18:35.858658231Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-10-20T21:18:35.858666147Z -- add_column(:users, :interface_language, :string)
2025-10-20T21:18:35.858673973Z    -> 0.0006s
2025-10-20T21:18:35.858681678Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0038s) =============
2025-10-20T21:18:35.858689554Z 
2025-10-20T21:18:35.858697260Z Migrating to AddLockableToUsers (20240610120318)
2025-10-20T21:18:35.858705066Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-10-20T21:18:35.858712971Z -- change_table(:users)
2025-10-20T21:18:35.858720707Z    -> 0.0042s
2025-10-20T21:18:35.858728413Z == 20240610120318 AddLockableToUsers: migrated (0.0045s) ======================
2025-10-20T21:18:35.858736288Z 
2025-10-20T21:18:35.858752972Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-10-20T21:18:35.858760868Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-10-20T21:18:35.858768794Z -- add_column(:model_files, :attachment_data, :json)
2025-10-20T21:18:35.858776660Z    -> 0.0006s
2025-10-20T21:18:35.858784906Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0009s) ===========
2025-10-20T21:18:35.858792942Z 
2025-10-20T21:18:35.858802512Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-10-20T21:18:35.858810618Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-10-20T21:18:35.858819446Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0203s) ==================
2025-10-20T21:18:35.858828364Z 
2025-10-20T21:18:35.858836149Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-10-20T21:18:35.858844095Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-10-20T21:18:35.858852001Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-10-20T21:18:35.858860108Z    -> 0.0007s
2025-10-20T21:18:35.858868064Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0024s) ============
2025-10-20T21:18:35.858876270Z 
2025-10-20T21:18:35.858884256Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-10-20T21:18:35.858892403Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-10-20T21:18:35.858900319Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-10-20T21:18:35.858908144Z    -> 0.0006s
2025-10-20T21:18:35.858915870Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-10-20T21:18:35.858923706Z    -> 0.0006s
2025-10-20T21:18:35.858931451Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-10-20T21:18:35.858939237Z    -> 0.0006s
2025-10-20T21:18:35.858946953Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-10-20T21:18:35.858955069Z    -> 0.0047s
2025-10-20T21:18:35.858963125Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-10-20T21:18:35.858971422Z    -> 0.0007s
2025-10-20T21:18:35.858979618Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0084s) ====================
2025-10-20T21:18:35.858987594Z 
2025-10-20T21:18:35.858995140Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-10-20T21:18:35.859002945Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-10-20T21:18:35.859010811Z -- remove_index(:libraries, :path)
2025-10-20T21:18:35.859018607Z    -> 0.0010s
2025-10-20T21:18:35.859026713Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0016s) ================
2025-10-20T21:18:35.859044359Z 
2025-10-20T21:18:35.859051974Z Migrating to CreateFederailsActors (20240727113215)
2025-10-20T21:18:35.859059780Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-10-20T21:18:35.859067716Z -- create_table(:federails_actors)
2025-10-20T21:18:35.859075491Z    -> 0.0009s
2025-10-20T21:18:35.859083217Z -- foreign_key_exists?(:federails_actors, :users)
2025-10-20T21:18:35.859091033Z    -> 0.0020s
2025-10-20T21:18:35.859099039Z -- remove_foreign_key(:federails_actors, :users)
2025-10-20T21:18:35.859107125Z    -> 0.0238s
2025-10-20T21:18:35.859115362Z -- remove_index(:federails_actors, :user_id)
2025-10-20T21:18:35.859123358Z    -> 0.0004s
2025-10-20T21:18:35.859131404Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-10-20T21:18:35.859139931Z    -> 0.0001s
2025-10-20T21:18:35.859148318Z -- add_foreign_key(:federails_actors, :users)
2025-10-20T21:18:35.859156655Z    -> 0.0234s
2025-10-20T21:18:35.859164731Z == 20240727113215 CreateFederailsActors: migrated (0.0515s) ===================
2025-10-20T21:18:35.859172807Z 
2025-10-20T21:18:35.859181244Z Migrating to CreateFederailsFollowings (20240727113216)
2025-10-20T21:18:35.859189230Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-10-20T21:18:35.859197367Z -- create_table(:federails_followings)
2025-10-20T21:18:35.859205373Z    -> 0.0043s
2025-10-20T21:18:35.859213349Z == 20240727113216 CreateFederailsFollowings: migrated (0.0043s) ===============
2025-10-20T21:18:35.859221285Z 
2025-10-20T21:18:35.859229762Z Migrating to CreateFederailsActivities (20240727113217)
2025-10-20T21:18:35.859238049Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-10-20T21:18:35.859246005Z -- create_table(:federails_activities)
2025-10-20T21:18:35.859253780Z    -> 0.0099s
2025-10-20T21:18:35.859261576Z == 20240727113217 CreateFederailsActivities: migrated (0.0106s) ===============
2025-10-20T21:18:35.859269732Z 
2025-10-20T21:18:35.859277518Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-10-20T21:18:35.859285745Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-10-20T21:18:35.859293971Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-10-20T21:18:35.859302037Z    -> 0.0225s
2025-10-20T21:18:35.859309793Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-10-20T21:18:35.859317919Z    -> 0.0004s
2025-10-20T21:18:35.859335034Z -- change_table(:federails_actors)
2025-10-20T21:18:35.859342890Z    -> 0.0091s
2025-10-20T21:18:35.859350635Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0321s) =======
2025-10-20T21:18:35.859358521Z 
2025-10-20T21:18:35.859366567Z Migrating to CreateFederailsActors (20240731165647)
2025-10-20T21:18:35.859374423Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-10-20T21:18:35.859382369Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-10-20T21:18:35.859390295Z 
2025-10-20T21:18:35.859398171Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-10-20T21:18:35.859406037Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-10-20T21:18:35.859414343Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-10-20T21:18:35.859422520Z 
2025-10-20T21:18:35.859430215Z Migrating to BackfillActivities (20240805111500)
2025-10-20T21:18:35.859438041Z == 20240805111500 BackfillActivities: migrating ===============================
2025-10-20T21:18:35.859445927Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-10-20T21:18:35.859453843Z 
2025-10-20T21:18:35.859461418Z Migrating to CreateCaberRelations (20240827155630)
2025-10-20T21:18:35.859469234Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-10-20T21:18:35.859477210Z -- create_table(:caber_relations)
2025-10-20T21:18:35.859484986Z    -> 0.0547s
2025-10-20T21:18:35.859492751Z == 20240827155630 CreateCaberRelations: migrated (0.0548s) ====================
2025-10-20T21:18:35.859500707Z 
2025-10-20T21:18:35.859508523Z Migrating to AddDefaultAccessControls (20240830121749)
2025-10-20T21:18:35.859516369Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-10-20T21:18:36.536036971Z == 20240830121749 AddDefaultAccessControls: migrated (0.0562s) ================
2025-10-20T21:18:36.536075067Z 
2025-10-20T21:18:36.536086220Z Migrating to RenameDefaultRoles (20240830151650)
2025-10-20T21:18:36.536096631Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-10-20T21:18:36.536105448Z == 20240830151650 RenameDefaultRoles: migrated (0.0439s) ======================
2025-10-20T21:18:36.536113495Z 
2025-10-20T21:18:36.536121170Z Migrating to AddPublicIDsToModels (20240904151944)
2025-10-20T21:18:36.536129707Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-10-20T21:18:36.536137643Z -- add_column(:models, :public_id, :string)
2025-10-20T21:18:36.536145449Z    -> 0.0010s
2025-10-20T21:18:36.536153635Z -- add_index(:models, :public_id)
2025-10-20T21:18:36.536180830Z    -> 0.0027s
2025-10-20T21:18:36.536189277Z -- add_column(:model_files, :public_id, :string)
2025-10-20T21:18:36.536197283Z    -> 0.0011s
2025-10-20T21:18:36.536205159Z -- add_index(:model_files, :public_id)
2025-10-20T21:18:36.536213095Z    -> 0.0002s
2025-10-20T21:18:36.536220921Z -- add_column(:problems, :public_id, :string)
2025-10-20T21:18:36.536228927Z    -> 0.0007s
2025-10-20T21:18:36.536236773Z -- add_index(:problems, :public_id)
2025-10-20T21:18:36.536246112Z    -> 0.0001s
2025-10-20T21:18:36.536255881Z -- add_column(:creators, :public_id, :string)
2025-10-20T21:18:36.536264940Z    -> 0.0007s
2025-10-20T21:18:36.536272996Z -- add_index(:creators, :public_id)
2025-10-20T21:18:36.536280892Z    -> 0.0002s
2025-10-20T21:18:36.536288737Z -- add_column(:collections, :public_id, :string)
2025-10-20T21:18:36.536296653Z    -> 0.0007s
2025-10-20T21:18:36.536304459Z -- add_index(:collections, :public_id)
2025-10-20T21:18:36.536312385Z    -> 0.0001s
2025-10-20T21:18:36.536320201Z -- add_column(:libraries, :public_id, :string)
2025-10-20T21:18:36.536329710Z    -> 0.0007s
2025-10-20T21:18:36.536339480Z -- add_index(:libraries, :public_id)
2025-10-20T21:18:36.536348488Z    -> 0.0001s
2025-10-20T21:18:36.536356404Z == 20240904151944 AddPublicIDsToModels: migrated (0.0084s) ====================
2025-10-20T21:18:36.536364480Z 
2025-10-20T21:18:36.536372266Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-10-20T21:18:36.536380442Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-10-20T21:18:36.536388398Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:36.536396394Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0700s) ==============
2025-10-20T21:18:36.536404380Z 
2025-10-20T21:18:36.536414010Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-10-20T21:18:36.536424000Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-10-20T21:18:36.536433539Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-10-20T21:18:36.536441615Z 
2025-10-20T21:18:36.536450062Z Migrating to DeduplicateRoles (20240923114515)
2025-10-20T21:18:36.536459211Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-10-20T21:18:36.536470313Z == 20240923114515 DeduplicateRoles: migrated (0.1344s) ========================
2025-10-20T21:18:36.536481385Z 
2025-10-20T21:18:36.536491145Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-10-20T21:18:36.536509251Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-10-20T21:18:36.536518791Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-20T21:18:36.536527508Z    -> 0.1554s
2025-10-20T21:18:36.536535825Z -- add_index(:models, :name_lower)
2025-10-20T21:18:36.536543851Z    -> 0.0002s
2025-10-20T21:18:36.536552659Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-20T21:18:36.536563571Z    -> 0.0074s
2025-10-20T21:18:36.536573350Z -- add_index(:creators, :name_lower)
2025-10-20T21:18:36.536581798Z    -> 0.0002s
2025-10-20T21:18:36.536589683Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-20T21:18:36.536597900Z    -> 0.0097s
2025-10-20T21:18:36.536606137Z -- add_index(:collections, :name_lower)
2025-10-20T21:18:36.536614002Z    -> 0.0001s
2025-10-20T21:18:36.536621758Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1731s) =============
2025-10-20T21:18:36.536629764Z 
2025-10-20T21:18:36.536637369Z Migrating to AddKeypairToActors (20240926162407)
2025-10-20T21:18:36.536645195Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-10-20T21:18:36.536653121Z -- change_table(:federails_actors)
2025-10-20T21:18:36.536661007Z    -> 0.0015s
2025-10-20T21:18:36.536669053Z == 20240926162407 AddKeypairToActors: migrated (0.0015s) ======================
2025-10-20T21:18:36.536677240Z 
2025-10-20T21:18:36.536685196Z Migrating to AddUuids (20241004194445)
2025-10-20T21:18:36.536693272Z == 20241004194445 AddUuids: migrating =========================================
2025-10-20T21:18:36.536701408Z -- change_table(:federails_actors)
2025-10-20T21:18:36.536709224Z    -> 0.0029s
2025-10-20T21:18:36.536717441Z -- change_table(:federails_activities)
2025-10-20T21:18:36.536725457Z    -> 0.0009s
2025-10-20T21:18:36.536733723Z -- change_table(:federails_followings)
2025-10-20T21:18:36.536742000Z    -> 0.0008s
2025-10-20T21:18:36.536750046Z == 20241004194445 AddUuids: migrated (0.0047s) ================================
2025-10-20T21:18:36.536758333Z 
2025-10-20T21:18:36.536766149Z Migrating to CreateComments (20241007182824)
2025-10-20T21:18:36.536774115Z == 20241007182824 CreateComments: migrating ===================================
2025-10-20T21:18:36.536782522Z -- create_table(:comments)
2025-10-20T21:18:36.536790568Z    -> 0.0019s
2025-10-20T21:18:36.536798704Z == 20241007182824 CreateComments: migrated (0.0019s) ==========================
2025-10-20T21:18:36.536820127Z 
2025-10-20T21:18:36.536829156Z Migrating to AddSystemToComments (20241009122540)
2025-10-20T21:18:36.536837552Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-10-20T21:18:36.536847913Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-10-20T21:18:36.536856120Z    -> 0.0008s
2025-10-20T21:18:36.536863926Z == 20241009122540 AddSystemToComments: migrated (0.0008s) =====================
2025-10-20T21:18:36.536871992Z 
2025-10-20T21:18:36.536880098Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-10-20T21:18:36.536889647Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-10-20T21:18:36.536899728Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0015s) ============
2025-10-20T21:18:36.536909708Z 
2025-10-20T21:18:36.536917784Z Migrating to AddOmniauthToUsers (20241015090803)
2025-10-20T21:18:36.536925650Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-10-20T21:18:36.536933766Z -- add_column(:users, :auth_provider, :string)
2025-10-20T21:18:36.536942203Z    -> 0.0008s
2025-10-20T21:18:36.536950219Z -- add_column(:users, :auth_uid, :string)
2025-10-20T21:18:36.536958085Z    -> 0.0007s
2025-10-20T21:18:36.536965831Z == 20241015090803 AddOmniauthToUsers: migrated (0.0015s) ======================
2025-10-20T21:18:36.536975190Z 
2025-10-20T21:18:36.536984839Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-10-20T21:18:36.536994238Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-10-20T21:18:36.537002224Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-10-20T21:18:36.537010260Z    -> 0.0008s
2025-10-20T21:18:36.537018176Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-10-20T21:18:36.537026182Z    -> 0.0007s
2025-10-20T21:18:36.537034088Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0016s) =====
2025-10-20T21:18:36.537042094Z 
2025-10-20T21:18:36.537049740Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-10-20T21:18:36.537059299Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-10-20T21:18:36.537069129Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-10-20T21:18:36.537078648Z    -> 0.0008s
2025-10-20T21:18:36.537086654Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-10-20T21:18:36.537094620Z 
2025-10-20T21:18:36.537102295Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-10-20T21:18:36.537111975Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-10-20T21:18:36.537129941Z -- change_table(:users)
2025-10-20T21:18:36.537138639Z    -> 0.0010s
2025-10-20T21:18:36.537148368Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-10-20T21:18:36.537158649Z 
2025-10-20T21:18:36.537166815Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-10-20T21:18:36.537174721Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-10-20T21:18:36.537182767Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0079s) =================
2025-10-20T21:18:36.537191004Z 
2025-10-20T21:18:36.537198680Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-10-20T21:18:36.537206896Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-10-20T21:18:36.537214892Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-10-20T21:18:36.537224281Z    -> 0.0009s
2025-10-20T21:18:36.537234111Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-10-20T21:18:36.537244331Z    -> 0.0012s
2025-10-20T21:18:36.537252328Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-10-20T21:18:36.537260484Z    -> 0.0004s
2025-10-20T21:18:36.537268360Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-10-20T21:18:36.537276837Z    -> 0.0010s
2025-10-20T21:18:36.537284653Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-10-20T21:18:36.537292879Z    -> 0.0009s
2025-10-20T21:18:36.537301787Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-10-20T21:18:36.537311847Z    -> 0.0007s
2025-10-20T21:18:36.537321968Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-10-20T21:18:36.537331116Z    -> 0.0005s
2025-10-20T21:18:36.537339182Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0060s) ===================
2025-10-20T21:18:36.537347980Z 
2025-10-20T21:18:36.537355646Z Migrating to AddInProgressToProblems (20241105121830)
2025-10-20T21:18:36.537363942Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-10-20T21:18:36.537372850Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-10-20T21:18:36.537380987Z    -> 0.0009s
2025-10-20T21:18:36.537389824Z == 20241105121830 AddInProgressToProblems: migrated (0.0009s) =================
2025-10-20T21:18:36.537400145Z 
2025-10-20T21:18:36.537409764Z Migrating to ClearStuckProblems (20241118155027)
2025-10-20T21:18:36.537434645Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-10-20T21:18:36.537444635Z == 20241118155027 ClearStuckProblems: migrated (0.0166s) ======================
2025-10-20T21:18:36.537452771Z 
2025-10-20T21:18:36.537460757Z Migrating to AddApprovedToUser (20241122121621)
2025-10-20T21:18:36.537468633Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-10-20T21:18:36.537476649Z -- change_table(:users)
2025-10-20T21:18:36.537484615Z    -> 0.0015s
2025-10-20T21:18:36.537493764Z == 20241122121621 AddApprovedToUser: migrated (0.0016s) =======================
2025-10-20T21:18:36.537503794Z 
2025-10-20T21:18:36.537512491Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-10-20T21:18:36.537520437Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-10-20T21:18:36.537528584Z -- create_table(:federails_moderation_reports)
2025-10-20T21:18:36.537536430Z    -> 0.0030s
2025-10-20T21:18:36.537544205Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0030s) ========
2025-10-20T21:18:36.537552121Z 
2025-10-20T21:18:36.537559766Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-10-20T21:18:36.537567682Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-10-20T21:18:36.537576991Z -- create_table(:federails_moderation_domain_blocks)
2025-10-20T21:18:36.537586891Z    -> 0.0008s
2025-10-20T21:18:36.537596400Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0008s) ===
2025-10-20T21:18:36.537604717Z 
2025-10-20T21:18:36.537612733Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-10-20T21:18:36.537620659Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-10-20T21:18:36.537628605Z -- change_column_null(:comments, :commenter_id, true)
2025-10-20T21:18:36.537636521Z    -> 0.0083s
2025-10-20T21:18:36.537644527Z -- change_column_null(:comments, :commenter_type, true)
2025-10-20T21:18:36.537652393Z    -> 0.0083s
2025-10-20T21:18:36.537661571Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-10-20T21:18:36.537671652Z    -> 0.0008s
2025-10-20T21:18:36.537680610Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-10-20T21:18:36.537688686Z    -> 0.0113s
2025-10-20T21:18:37.286283000Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0302s) =======
2025-10-20T21:18:37.286340777Z 
2025-10-20T21:18:37.286351989Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-10-20T21:18:37.286364244Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-10-20T21:18:37.286415888Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-10-20T21:18:37.286426038Z    -> 0.0010s
2025-10-20T21:18:37.286435758Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0011s) =================
2025-10-20T21:18:37.286445187Z 
2025-10-20T21:18:37.286454155Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-10-20T21:18:37.286463524Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-10-20T21:18:37.286473083Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1151s) ==================
2025-10-20T21:18:37.286482973Z 
2025-10-20T21:18:37.286492131Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-10-20T21:18:37.286501701Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-10-20T21:18:37.286511270Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-10-20T21:18:37.286521290Z    -> 0.0019s
2025-10-20T21:18:37.286530679Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0019s) ==========
2025-10-20T21:18:37.286540258Z 
2025-10-20T21:18:37.286549387Z Migrating to AddCreatorToCollections (20250222000000)
2025-10-20T21:18:37.286558836Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-10-20T21:18:37.286574768Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-10-20T21:18:37.286584618Z    -> 0.0222s
2025-10-20T21:18:37.286593435Z == 20250222000000 AddCreatorToCollections: migrated (0.0222s) =================
2025-10-20T21:18:37.286608576Z 
2025-10-20T21:18:37.286618786Z Migrating to AddLocalToActors (20250305171530)
2025-10-20T21:18:37.286627965Z == 20250305171530 AddLocalToActors: migrating =================================
2025-10-20T21:18:37.286637243Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-10-20T21:18:37.286646773Z    -> 0.0009s
2025-10-20T21:18:37.286656081Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-10-20T21:18:37.286666082Z    -> 0.0017s
2025-10-20T21:18:37.286675771Z    -> 0 rows
2025-10-20T21:18:37.286685030Z == 20250305171530 AddLocalToActors: migrated (0.0056s) ========================
2025-10-20T21:18:37.286698557Z 
2025-10-20T21:18:37.286709810Z Migrating to AddActorTypeToActors (20250407160721)
2025-10-20T21:18:37.286719078Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-10-20T21:18:37.286728808Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-10-20T21:18:37.286738227Z    -> 0.0009s
2025-10-20T21:18:37.286747536Z == 20250407160721 AddActorTypeToActors: migrated (0.0010s) ====================
2025-10-20T21:18:37.286768758Z 
2025-10-20T21:18:37.286777736Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-10-20T21:18:37.286790843Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-10-20T21:18:37.286806695Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-10-20T21:18:37.286816244Z    -> 0.0014s
2025-10-20T21:18:37.286825402Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0014s) =================
2025-10-20T21:18:37.286836815Z 
2025-10-20T21:18:37.286846064Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-10-20T21:18:37.286855613Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-10-20T21:18:37.286864902Z -- create_table(:oauth_applications)
2025-10-20T21:18:37.286875734Z    -> 0.0004s
2025-10-20T21:18:37.286884742Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-10-20T21:18:37.286894201Z    -> 0.0002s
2025-10-20T21:18:37.286903259Z -- create_table(:oauth_access_grants)
2025-10-20T21:18:37.286912427Z    -> 0.0006s
2025-10-20T21:18:37.286921666Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-10-20T21:18:37.286931155Z    -> 0.0002s
2025-10-20T21:18:37.286940504Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-10-20T21:18:37.286950344Z    -> 0.0076s
2025-10-20T21:18:37.286959893Z -- create_table(:oauth_access_tokens)
2025-10-20T21:18:37.286969092Z    -> 0.0006s
2025-10-20T21:18:37.286978561Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-10-20T21:18:37.286988010Z    -> 0.0002s
2025-10-20T21:18:37.286997138Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-10-20T21:18:37.287006377Z    -> 0.0001s
2025-10-20T21:18:37.287022098Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-10-20T21:18:37.287032128Z    -> 0.0118s
2025-10-20T21:18:37.287042269Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-10-20T21:18:37.287052890Z    -> 0.0074s
2025-10-20T21:18:37.287062830Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-10-20T21:18:37.287075325Z    -> 0.0243s
2025-10-20T21:18:37.287086047Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0536s) ==================
2025-10-20T21:18:37.287095396Z 
2025-10-20T21:18:37.287104454Z Migrating to AddOwnerToApplication (20250408145956)
2025-10-20T21:18:37.287114013Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-10-20T21:18:37.287134454Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-10-20T21:18:37.287147581Z    -> 0.0012s
2025-10-20T21:18:37.287159495Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-10-20T21:18:37.287168874Z    -> 0.0017s
2025-10-20T21:18:37.287178102Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-10-20T21:18:37.287188032Z    -> 0.0002s
2025-10-20T21:18:37.287198323Z == 20250408145956 AddOwnerToApplication: migrated (0.0080s) ===================
2025-10-20T21:18:37.287207762Z 
2025-10-20T21:18:37.287217081Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-10-20T21:18:37.287226620Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-10-20T21:18:37.287236941Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-10-20T21:18:37.287251530Z    -> 0.0120s
2025-10-20T21:18:37.287260899Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0135s) ============
2025-10-20T21:18:37.287271430Z 
2025-10-20T21:18:37.287280969Z Migrating to AddQuotaToUsers (20250409125753)
2025-10-20T21:18:37.287290418Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-10-20T21:18:37.287299727Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-10-20T21:18:37.287309096Z    -> 0.0011s
2025-10-20T21:18:37.287318505Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-10-20T21:18:37.287328134Z    -> 0.0009s
2025-10-20T21:18:37.287337463Z == 20250409125753 AddQuotaToUsers: migrated (0.0034s) =========================
2025-10-20T21:18:37.287346912Z 
2025-10-20T21:18:37.287356201Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-10-20T21:18:37.287365600Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-10-20T21:18:37.287375089Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-10-20T21:18:37.287384839Z    -> 0.0132s
2025-10-20T21:18:37.287394318Z -- add_index(:model_files, :filename_lower)
2025-10-20T21:18:37.287403697Z    -> 0.0002s
2025-10-20T21:18:37.287419288Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0148s) 
2025-10-20T21:18:37.287431022Z 
2025-10-20T21:18:37.287441663Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-10-20T21:18:37.287451052Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-10-20T21:18:37.287465020Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-10-20T21:18:37.287474459Z    -> 0.0002s
2025-10-20T21:18:37.287483748Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-10-20T21:18:37.287508497Z 
2025-10-20T21:18:37.287518387Z Migrating to AddPreviewToModelFile (20250520111046)
2025-10-20T21:18:37.287529590Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-10-20T21:18:37.287539009Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-10-20T21:18:37.287548298Z    -> 0.0011s
2025-10-20T21:18:37.287557376Z == 20250520111046 AddPreviewToModelFile: migrated (0.0019s) ===================
2025-10-20T21:18:37.287566484Z 
2025-10-20T21:18:37.287578218Z Migrating to CreateAltchaSolutions (20250609210440)
2025-10-20T21:18:37.287591424Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-10-20T21:18:37.287600773Z -- create_table(:altcha_solutions)
2025-10-20T21:18:37.287609842Z    -> 0.0004s
2025-10-20T21:18:37.287618910Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-10-20T21:18:37.287628750Z    -> 0.0002s
2025-10-20T21:18:37.287637948Z == 20250609210440 CreateAltchaSolutions: migrated (0.0017s) ===================
2025-10-20T21:18:37.287647457Z 
2025-10-20T21:18:37.287656836Z Migrating to AddIndexableFields (20250620141805)
2025-10-20T21:18:37.287666215Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-10-20T21:18:37.287675594Z -- change_table(:models)
2025-10-20T21:18:37.287684682Z    -> 0.0026s
2025-10-20T21:18:37.287698740Z -- change_table(:creators)
2025-10-20T21:18:37.287708430Z    -> 0.0017s
2025-10-20T21:18:37.287717679Z -- change_table(:collections)
2025-10-20T21:18:37.287726867Z    -> 0.0017s
2025-10-20T21:18:37.287737579Z == 20250620141805 AddIndexableFields: migrated (0.0060s) ======================
2025-10-20T21:18:37.287751697Z 
2025-10-20T21:18:37.287760936Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-10-20T21:18:37.287770725Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-10-20T21:18:37.287780515Z -- change_column(:models, :indexable, :string)
2025-10-20T21:18:37.287789654Z    -> 0.0306s
2025-10-20T21:18:37.287798672Z -- change_column(:models, :ai_indexable, :string)
2025-10-20T21:18:37.287809473Z    -> 0.0178s
2025-10-20T21:18:37.287818662Z -- change_column(:creators, :indexable, :string)
2025-10-20T21:18:37.287828061Z    -> 0.0095s
2025-10-20T21:18:37.287837450Z -- change_column(:creators, :ai_indexable, :string)
2025-10-20T21:18:37.287865937Z    -> 0.0090s
2025-10-20T21:18:37.287878683Z -- change_column(:collections, :indexable, :string)
2025-10-20T21:18:37.287898994Z    -> 0.0557s
2025-10-20T21:18:37.287911619Z -- change_column(:collections, :ai_indexable, :string)
2025-10-20T21:18:37.287920858Z    -> 0.0131s
2025-10-20T21:18:37.287930988Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1361s) ======
2025-10-20T21:18:37.287947030Z 
2025-10-20T21:18:37.287956159Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-10-20T21:18:37.287965467Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-10-20T21:18:37.287976840Z -- change_table(:models)
2025-10-20T21:18:37.287986680Z    -> 0.0004s
2025-10-20T21:18:37.287996690Z -- change_table(:creators)
2025-10-20T21:18:37.288005989Z    -> 0.0003s
2025-10-20T21:18:37.288015528Z -- change_table(:collections)
2025-10-20T21:18:37.288024677Z    -> 0.0003s
2025-10-20T21:18:37.288033875Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0010s) =================
2025-10-20T21:18:37.288043475Z 
2025-10-20T21:18:37.288053384Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-10-20T21:18:37.288063675Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-10-20T21:18:37.288073946Z -- change_table(:links)
2025-10-20T21:18:37.288082904Z    -> 0.0003s
2025-10-20T21:18:37.288092403Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0003s) =======================
2025-10-20T21:18:37.288101942Z 
2025-10-20T21:18:37.288110950Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-10-20T21:18:37.288120650Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-10-20T21:18:37.288130620Z -- add_column(:links, :synced_at, :datetime)
2025-10-20T21:18:37.288140400Z    -> 0.0011s
2025-10-20T21:18:37.288154779Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0012s) ======================
2025-10-20T21:18:37.288168646Z 
2025-10-20T21:18:37.288179949Z Migrating to CreateFaspClientProviders (20250806142734)
2025-10-20T21:18:37.288189629Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-10-20T21:18:37.288199118Z -- create_table(:fasp_client_providers)
2025-10-20T21:18:37.288208577Z    -> 0.0436s
2025-10-20T21:18:37.288218838Z == 20250806142734 CreateFaspClientProviders: migrated (0.0436s) ===============
2025-10-20T21:18:37.288228206Z 
2025-10-20T21:18:37.288237255Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-10-20T21:18:37.288246353Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-10-20T21:18:37.288255772Z -- create_table(:fasp_client_event_subscriptions)
2025-10-20T21:18:37.288278728Z    -> 0.0141s
2025-10-20T21:18:37.348333884Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0141s) ======
2025-10-20T21:18:37.348374516Z 
2025-10-20T21:18:37.348384496Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-10-20T21:18:37.348392753Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-10-20T21:18:37.348400929Z -- create_table(:fasp_client_backfill_requests)
2025-10-20T21:18:37.348409126Z    -> 0.0053s
2025-10-20T21:18:37.348417342Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0053s) ========
2025-10-20T21:18:37.348425649Z 
2025-10-20T21:18:37.348433615Z Migrating to AddImagesToCreators (20250922155445)
2025-10-20T21:18:37.348441591Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-10-20T21:18:37.348449607Z -- add_column(:creators, :avatar_data, :json)
2025-10-20T21:18:37.348457763Z    -> 0.0010s
2025-10-20T21:18:37.348465599Z -- add_column(:creators, :banner_data, :json)
2025-10-20T21:18:37.348473605Z    -> 0.0011s
2025-10-20T21:18:37.348481431Z == 20250922155445 AddImagesToCreators: migrated (0.0022s) =====================
2025-10-20T21:18:37.348489467Z 
2025-10-20T21:18:37.348497143Z Migrating to CreateFederailsHosts (20251010145758)
2025-10-20T21:18:37.348505039Z == 20251010145758 CreateFederailsHosts: migrating =============================
2025-10-20T21:18:37.348513295Z -- create_table(:federails_hosts)
2025-10-20T21:18:37.348521542Z    -> 0.0193s
2025-10-20T21:18:37.348529398Z == 20251010145758 CreateFederailsHosts: migrated (0.0193s) ====================
2025-10-20T21:18:37.348539288Z 
2025-10-20T21:18:37.416085725Z s6-rc: info: service init-manyfold-config successfully started
2025-10-20T21:18:37.416415138Z s6-rc: info: service init-config-end: starting
2025-10-20T21:18:37.418684046Z s6-rc: info: service init-config-end successfully started
2025-10-20T21:18:37.418951514Z s6-rc: info: service init-mods: starting
2025-10-20T21:18:37.421171895Z s6-rc: info: service init-mods successfully started
2025-10-20T21:18:37.421406427Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-10-20T21:18:37.430465425Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-10-20T21:18:37.430723655Z s6-rc: info: service init-mods-package-install: starting
2025-10-20T21:18:37.442341745Z [pkg-install-init] **** Installing all mod packages ****
2025-10-20T21:18:37.452926885Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-10-20T21:18:37.531754895Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-10-20T21:18:37.877210302Z (1/1) Installing redis (8.0.4-r0)
2025-10-20T21:18:37.887882488Z Executing redis-8.0.4-r0.pre-install
2025-10-20T21:18:37.928801227Z Executing redis-8.0.4-r0.post-install
2025-10-20T21:18:37.936954712Z Executing busybox-1.37.0-r19.trigger
2025-10-20T21:18:37.951967847Z OK: 428 MiB in 119 packages
2025-10-20T21:18:38.051556604Z s6-rc: info: service init-mods-package-install successfully started
2025-10-20T21:18:38.051822730Z s6-rc: info: service init-mods-end: starting
2025-10-20T21:18:38.053818107Z s6-rc: info: service init-mods-end successfully started
2025-10-20T21:18:38.053988189Z s6-rc: info: service init-custom-files: starting
2025-10-20T21:18:38.061838504Z [custom-init] No custom files found, skipping...
2025-10-20T21:18:38.062733526Z s6-rc: info: service init-custom-files successfully started
2025-10-20T21:18:38.062857546Z s6-rc: info: service init-services: starting
2025-10-20T21:18:38.065911975Z s6-rc: info: service init-services successfully started
2025-10-20T21:18:38.065951875Z s6-rc: info: service svc-mod-universal-redis: starting
2025-10-20T21:18:38.072260716Z s6-rc: info: service svc-manyfold: starting
2025-10-20T21:18:38.072364936Z s6-rc: info: service svc-cron: starting
2025-10-20T21:18:38.072497914Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-10-20T21:18:38.075337190Z s6-rc: info: service svc-cron successfully started
2025-10-20T21:18:38.079073923Z 277:C 20 Oct 2025 21:18:38.078 # 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-20T21:18:38.079120046Z 277:C 20 Oct 2025 21:18:38.079 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-10-20T21:18:38.079129966Z 277:C 20 Oct 2025 21:18:38.079 * Redis version=8.0.4, bits=64, commit=00000000, modified=1, pid=277, just started
2025-10-20T21:18:38.079138583Z 277:C 20 Oct 2025 21:18:38.079 # 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-20T21:18:38.079735104Z 277:M 20 Oct 2025 21:18:38.079 * monotonic clock: POSIX clock_gettime
2025-10-20T21:18:38.080196834Z 277:M 20 Oct 2025 21:18:38.080 * Running mode=standalone, port=6379.
2025-10-20T21:18:38.080531157Z 277:M 20 Oct 2025 21:18:38.080 * Server initialized
2025-10-20T21:18:38.080564514Z 277:M 20 Oct 2025 21:18:38.080 * Ready to accept connections tcp
2025-10-20T21:18:38.270654742Z 21:18:38 rails.1              | started with pid 301
2025-10-20T21:18:38.270714072Z 21:18:38 default_worker.1     | started with pid 302
2025-10-20T21:18:38.270741557Z 21:18:38 performance_worker.1 | started with pid 303
2025-10-20T21:18:39.526078349Z 21:18:39 rails.1              | `/root` is not writable.
2025-10-20T21:18:39.526145664Z 21:18:39 rails.1              | Bundler will use `/tmp/bundler20251020-301-n5kdm8301' as your home directory temporarily.
2025-10-20T21:18:40.018900009Z 21:18:40 performance_worker.1 | `/root` is not writable.
2025-10-20T21:18:40.018930441Z 21:18:40 performance_worker.1 | Bundler will use `/tmp/bundler20251020-303-pw9q4e303' as your home directory temporarily.
2025-10-20T21:18:40.021127163Z 21:18:40 default_worker.1     | `/root` is not writable.
2025-10-20T21:18:40.021152865Z 21:18:40 default_worker.1     | Bundler will use `/tmp/bundler20251020-302-riupuq302' as your home directory temporarily.
2025-10-20T21:18:40.924229751Z 21:18:40 rails.1              | => Booting Puma
2025-10-20T21:18:40.924260223Z 21:18:40 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-10-20T21:18:40.924266064Z 21:18:40 rails.1              | => Run `bin/rails server --help` for more startup options
2025-10-20T21:18:41.501552654Z 21:18:41 default_worker.1     | Server: 7efd1ffbaf0c, Context: rails, Role: web, data: {cpu: {one_min: 2.54, five_min: 1.63, fifteen_min: 3.12}, memory: 0.191606784e9, disk: {available: 832761872384, total: 938656133120, used: 105894260736}}
2025-10-20T21:18:41.522640730Z 21:18:41 performance_worker.1 | Server: 7efd1ffbaf0c, Context: rails, Role: web, data: {cpu: {one_min: 2.54, five_min: 1.63, fifteen_min: 3.12}, memory: 0.191864832e9, disk: {available: 832761737216, total: 938656133120, used: 105894395904}}
2025-10-20T21:18:43.607291465Z 21:18:43 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:43.608484978Z 21:18:43 performance_worker.1 | INFO  2025-10-20T21:18:43.608Z pid=303 tid=247: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-20T21:18:43.610315103Z 21:18:43 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:43.611436230Z 21:18:43 default_worker.1     | INFO  2025-10-20T21:18:43.611Z pid=302 tid=246: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-20T21:18:43.674779515Z 21:18:43 performance_worker.1 | INFO  2025-10-20T21:18:43.674Z pid=303 tid=247: Booted Rails 8.0.2.1 application in production environment
2025-10-20T21:18:43.674815859Z 21:18:43 performance_worker.1 | INFO  2025-10-20T21:18:43.674Z pid=303 tid=247: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-20T21:18:43.674941291Z 21:18:43 performance_worker.1 | INFO  2025-10-20T21:18:43.674Z pid=303 tid=247: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-20T21:18:43.674969849Z 21:18:43 performance_worker.1 | INFO  2025-10-20T21:18:43.674Z pid=303 tid=247: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-20T21:18:43.675889019Z 21:18:43 default_worker.1     | INFO  2025-10-20T21:18:43.675Z pid=302 tid=246: Booted Rails 8.0.2.1 application in production environment
2025-10-20T21:18:43.675910703Z 21:18:43 default_worker.1     | INFO  2025-10-20T21:18:43.675Z pid=302 tid=246: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-20T21:18:43.676024642Z 21:18:43 default_worker.1     | INFO  2025-10-20T21:18:43.675Z pid=302 tid=246: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-20T21:18:43.676052879Z 21:18:43 default_worker.1     | INFO  2025-10-20T21:18:43.675Z pid=302 tid=246: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-20T21:18:43.678416628Z 21:18:43 performance_worker.1 | INFO  2025-10-20T21:18:43.678Z pid=303 tid=247: Sidekiq 8.0.8 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-10-20T21:18:43.678446648Z 21:18:43 default_worker.1     | INFO  2025-10-20T21:18:43.678Z pid=302 tid=246: Sidekiq 8.0.8 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-10-20T21:18:43.764078546Z 21:18:43 rails.1              | Server: 7efd1ffbaf0c, Context: rails, Role: web, data: {cpu: {one_min: 2.54, five_min: 1.63, fifteen_min: 3.12}, memory: 0.176930816e9, disk: {available: 832762843136, total: 938656133120, used: 105893289984}}
2025-10-20T21:18:43.764117495Z 21:18:43 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:43.764129800Z 21:18:43 rails.1              | INFO  2025-10-20T21:18:43.602Z pid=301 tid=205: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-20T21:18:43.764165311Z 21:18:43 rails.1              | INFO  2025-10-20T21:18:43.606Z pid=301 tid=205: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-20T21:18:43.764209971Z 21:18:43 rails.1              | INFO  2025-10-20T21:18:43.608Z pid=301 tid=205: Cron Jobs - added job with name clear-downloads in the namespace default
2025-10-20T21:18:43.764271966Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 32359d13-bc6a-4555-bfce-dea05023b3db) 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-20T21:18:43.764311966Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: c24bef6a-b115-402e-b5b2-15874346048f) 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-20T21:18:43.764361947Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: e35ad632-aca9-4dbb-8afe-8fd966fee3c8) 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-20T21:18:43.764406406Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 3f455e0a-ca0a-46b8-b63e-5068428ce51f) to Sidekiq(upgrade)
2025-10-20T21:18:43.764727353Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 82f906d4-6598-4e55-b28a-fa3c4e5136a9) to Sidekiq(upgrade)
2025-10-20T21:18:43.764737914Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 60e68246-d86c-4b6f-add9-200f08b60f46) to Sidekiq(upgrade)
2025-10-20T21:18:43.770783385Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: d3e2beaf-4260-4f29-b375-a81cad7df806) to Sidekiq(upgrade)
2025-10-20T21:18:43.770938086Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 12b643c8-d44a-4924-aee8-5cd003118c13) to Sidekiq(upgrade)
2025-10-20T21:18:43.770957736Z 21:18:43 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: f19dfbf3-85a6-4039-9401-cd19548f4bab) to Sidekiq(upgrade)
2025-10-20T21:18:43.771005262Z 21:18:43 rails.1              | [301] Puma starting in cluster mode...
2025-10-20T21:18:43.771063729Z 21:18:43 rails.1              | [301] * Puma version: 7.0.4 ("Romantic Warrior")
2025-10-20T21:18:43.771123610Z 21:18:43 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-20T21:18:43.771152709Z 21:18:43 rails.1              | [301] *  Min threads: 4
2025-10-20T21:18:43.771201467Z 21:18:43 rails.1              | [301] *  Max threads: 16
2025-10-20T21:18:43.771243732Z 21:18:43 rails.1              | [301] *  Environment: production
2025-10-20T21:18:43.771296398Z 21:18:43 rails.1              | [301] *   Master PID: 301
2025-10-20T21:18:43.771343493Z 21:18:43 rails.1              | [301] *      Workers: 4
2025-10-20T21:18:43.771386088Z 21:18:43 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-10-20T21:18:43.771432392Z 21:18:43 rails.1              | [301] * Preloading application
2025-10-20T21:18:43.771488715Z 21:18:43 rails.1              | [301] * Listening on http://[::]:3214
2025-10-20T21:18:43.771534207Z 21:18:43 rails.1              | [301] Use Ctrl-C to stop
2025-10-20T21:18:43.796772086Z 21:18:43 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-10-20T21:18:43.796805193Z 21:18:43 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.02s, phase: 0
2025-10-20T21:18:43.796820333Z 21:18:43 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-10-20T21:18:43.798437810Z 21:18:43 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-10-20T21:18:43.943308670Z 21:18:43 performance_worker.1 | Server: 7efd1ffbaf0c, Context: sidekiq, Role: background, data: {cpu: {one_min: 2.54, five_min: 1.63, fifteen_min: 3.12}, memory: 0.232484864e9, disk: {available: 832755171328, total: 938656133120, used: 105900961792}}
2025-10-20T21:18:43.955337297Z 21:18:43 default_worker.1     | Server: 7efd1ffbaf0c, Context: sidekiq, Role: background, data: {cpu: {one_min: 2.54, five_min: 1.63, fifteen_min: 3.12}, memory: 0.229965824e9, disk: {available: 832755171328, total: 938656133120, used: 105900961792}}
2025-10-20T21:18:44.043093522Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.042Z pid=302 tid=hnq jid=5010d61c401bffb0e6f793f2 class=Upgrade::GenerateSlugsJob: start
2025-10-20T21:18:44.052224114Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [32359d13-bc6a-4555-bfce-dea05023b3db] Performing Upgrade::GenerateSlugsJob (Job ID: 32359d13-bc6a-4555-bfce-dea05023b3db) from Sidekiq(high) enqueued at 2025-10-20T21:18:43.621193554Z 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-20T21:18:44.056233486Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.042Z pid=302 tid=hoe jid=67f2cd8c1276ade6627c8c46 class=Upgrade::GenerateSlugsJob: start
2025-10-20T21:18:44.075797133Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [c24bef6a-b115-402e-b5b2-15874346048f] Performing Upgrade::GenerateSlugsJob (Job ID: c24bef6a-b115-402e-b5b2-15874346048f) from Sidekiq(high) enqueued at 2025-10-20T21:18:43.623981887Z 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-20T21:18:44.099798804Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.042Z pid=302 tid=ho6 jid=dbd68a07d17b5cae31776d9e class=Upgrade::GenerateSlugsJob: start
2025-10-20T21:18:44.104802237Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-10-20T21:18:44.106092725Z s6-rc: info: service svc-manyfold successfully started
2025-10-20T21:18:44.106303660Z s6-rc: info: service legacy-services: starting
2025-10-20T21:18:44.117879565Z s6-rc: info: service legacy-services successfully started
2025-10-20T21:18:44.118111442Z s6-rc: info: service ci-service-check: starting
2025-10-20T21:18:44.121472549Z [ls.io-init] done.
2025-10-20T21:18:44.122254673Z s6-rc: info: service ci-service-check successfully started
2025-10-20T21:18:44.144550400Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e35ad632-aca9-4dbb-8afe-8fd966fee3c8] Performing Upgrade::GenerateSlugsJob (Job ID: e35ad632-aca9-4dbb-8afe-8fd966fee3c8) from Sidekiq(high) enqueued at 2025-10-20T21:18:43.626205223Z 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-20T21:18:44.145969677Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.052Z pid=302 tid=hpi jid=3d06aedae29cea002bc4bad4 class=Upgrade::FixNilFileSizeValues: start
2025-10-20T21:18:44.147091245Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3f455e0a-ca0a-46b8-b63e-5068428ce51f] Performing Upgrade::FixNilFileSizeValues (Job ID: 3f455e0a-ca0a-46b8-b63e-5068428ce51f) from Sidekiq(upgrade) enqueued at 2025-10-20T21:18:43.627887881Z
2025-10-20T21:18:44.151658400Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [c24bef6a-b115-402e-b5b2-15874346048f] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:44.173205530Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e35ad632-aca9-4dbb-8afe-8fd966fee3c8] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:44.199028568Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3f455e0a-ca0a-46b8-b63e-5068428ce51f] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:44.214310795Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [c24bef6a-b115-402e-b5b2-15874346048f] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-20T21:18:44.288821253Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [c24bef6a-b115-402e-b5b2-15874346048f] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.086
2025-10-20T21:18:44.413400962Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e35ad632-aca9-4dbb-8afe-8fd966fee3c8] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-20T21:18:44.504922708Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e35ad632-aca9-4dbb-8afe-8fd966fee3c8] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.277
2025-10-20T21:18:44.517464889Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3f455e0a-ca0a-46b8-b63e-5068428ce51f] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-20T21:18:44.524495934Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3f455e0a-ca0a-46b8-b63e-5068428ce51f] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.214
2025-10-20T21:18:44.539282223Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [32359d13-bc6a-4555-bfce-dea05023b3db] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:44.626350452Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [32359d13-bc6a-4555-bfce-dea05023b3db] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-20T21:18:44.626392537Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [32359d13-bc6a-4555-bfce-dea05023b3db] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.081
2025-10-20T21:18:44.655319564Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [c24bef6a-b115-402e-b5b2-15874346048f] Performed Upgrade::GenerateSlugsJob (Job ID: c24bef6a-b115-402e-b5b2-15874346048f) from Sidekiq(high) in 594.59ms
2025-10-20T21:18:44.680336650Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e35ad632-aca9-4dbb-8afe-8fd966fee3c8] Performed Upgrade::GenerateSlugsJob (Job ID: e35ad632-aca9-4dbb-8afe-8fd966fee3c8) from Sidekiq(high) in 560.49ms
2025-10-20T21:18:44.681646226Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [32359d13-bc6a-4555-bfce-dea05023b3db] Performed Upgrade::GenerateSlugsJob (Job ID: 32359d13-bc6a-4555-bfce-dea05023b3db) from Sidekiq(high) in 633.52ms
2025-10-20T21:18:44.684145979Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3f455e0a-ca0a-46b8-b63e-5068428ce51f] Performed Upgrade::FixNilFileSizeValues (Job ID: 3f455e0a-ca0a-46b8-b63e-5068428ce51f) from Sidekiq(upgrade) in 537.13ms
2025-10-20T21:18:44.684887472Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.680Z pid=302 tid=hoe jid=67f2cd8c1276ade6627c8c46 class=Upgrade::GenerateSlugsJob elapsed=0.638: done
2025-10-20T21:18:44.685123838Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.681Z pid=302 tid=ho6 jid=dbd68a07d17b5cae31776d9e class=Upgrade::GenerateSlugsJob elapsed=0.639: done
2025-10-20T21:18:44.694096372Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.693Z pid=302 tid=hoe jid=9a4cc9b5950ff4d1e4fe9d11 class=Upgrade::BackfillDataPackages: start
2025-10-20T21:18:44.696803011Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [82f906d4-6598-4e55-b28a-fa3c4e5136a9] Performing Upgrade::BackfillDataPackages (Job ID: 82f906d4-6598-4e55-b28a-fa3c4e5136a9) from Sidekiq(upgrade) enqueued at 2025-10-20T21:18:43.628562319Z
2025-10-20T21:18:44.697651770Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.693Z pid=302 tid=hpi jid=3d06aedae29cea002bc4bad4 class=Upgrade::FixNilFileSizeValues elapsed=0.641: done
2025-10-20T21:18:44.697787663Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.684Z pid=302 tid=hnq jid=5010d61c401bffb0e6f793f2 class=Upgrade::GenerateSlugsJob elapsed=0.641: done
2025-10-20T21:18:44.698318091Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.698Z pid=302 tid=hpi jid=70e77d64ff6388e7fdacb71d class=Upgrade::UpdateActorsJob: start
2025-10-20T21:18:44.699565663Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d3e2beaf-4260-4f29-b375-a81cad7df806] Performing Upgrade::UpdateActorsJob (Job ID: d3e2beaf-4260-4f29-b375-a81cad7df806) from Sidekiq(upgrade) enqueued at 2025-10-20T21:18:43.629826153Z
2025-10-20T21:18:44.705254115Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.694Z pid=302 tid=ho6 jid=c7438700e1f0ce8e293fb9ab class=Upgrade::DisambiguateUsernamesJob: start
2025-10-20T21:18:44.705795605Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [82f906d4-6598-4e55-b28a-fa3c4e5136a9] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:44.776876468Z 21:18:44 default_worker.1     | INFO  2025-10-20T21:18:44.698Z pid=302 tid=hnq jid=bd9880b45ccbc1f81dfd3cb6 class=Upgrade::FixParentCollections: start
2025-10-20T21:18:44.844750526Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [60e68246-d86c-4b6f-add9-200f08b60f46] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 60e68246-d86c-4b6f-add9-200f08b60f46) from Sidekiq(upgrade) enqueued at 2025-10-20T21:18:43.629199341Z
2025-10-20T21:18:44.850154325Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [12b643c8-d44a-4924-aee8-5cd003118c13] Performing Upgrade::FixParentCollections (Job ID: 12b643c8-d44a-4924-aee8-5cd003118c13) from Sidekiq(upgrade) enqueued at 2025-10-20T21:18:43.630455580Z
2025-10-20T21:18:44.945512444Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d3e2beaf-4260-4f29-b375-a81cad7df806] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:44.984183208Z 21:18:44 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [60e68246-d86c-4b6f-add9-200f08b60f46] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:45.003515389Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [12b643c8-d44a-4924-aee8-5cd003118c13] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:45.051752511Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [82f906d4-6598-4e55-b28a-fa3c4e5136a9] Performed Upgrade::BackfillDataPackages (Job ID: 82f906d4-6598-4e55-b28a-fa3c4e5136a9) from Sidekiq(upgrade) in 356.59ms
2025-10-20T21:18:45.151818399Z 21:18:45 default_worker.1     | INFO  2025-10-20T21:18:45.151Z pid=302 tid=hoe jid=9a4cc9b5950ff4d1e4fe9d11 class=Upgrade::BackfillDataPackages elapsed=0.456: done
2025-10-20T21:18:45.157126325Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d3e2beaf-4260-4f29-b375-a81cad7df806] Performed Upgrade::UpdateActorsJob (Job ID: d3e2beaf-4260-4f29-b375-a81cad7df806) from Sidekiq(upgrade) in 452.57ms
2025-10-20T21:18:45.160742656Z 21:18:45 default_worker.1     | INFO  2025-10-20T21:18:45.157Z pid=302 tid=hoe jid=f33a29ef939bc1bc8c9ba103 class=Upgrade::PruneOrphanedProblems: start
2025-10-20T21:18:45.186488629Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f19dfbf3-85a6-4039-9401-cd19548f4bab] Performing Upgrade::PruneOrphanedProblems (Job ID: f19dfbf3-85a6-4039-9401-cd19548f4bab) from Sidekiq(upgrade) enqueued at 2025-10-20T21:18:43.631106962Z
2025-10-20T21:18:45.187210071Z 21:18:45 default_worker.1     | INFO  2025-10-20T21:18:45.170Z pid=302 tid=hpi jid=70e77d64ff6388e7fdacb71d class=Upgrade::UpdateActorsJob elapsed=0.473: done
2025-10-20T21:18:45.197196616Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [60e68246-d86c-4b6f-add9-200f08b60f46] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 60e68246-d86c-4b6f-add9-200f08b60f46) from Sidekiq(upgrade) in 480.89ms
2025-10-20T21:18:45.197505478Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [12b643c8-d44a-4924-aee8-5cd003118c13] Performed Upgrade::FixParentCollections (Job ID: 12b643c8-d44a-4924-aee8-5cd003118c13) from Sidekiq(upgrade) in 375.49ms
2025-10-20T21:18:45.204522445Z 21:18:45 default_worker.1     | INFO  2025-10-20T21:18:45.204Z pid=302 tid=ho6 jid=c7438700e1f0ce8e293fb9ab class=Upgrade::DisambiguateUsernamesJob elapsed=0.51: done
2025-10-20T21:18:45.204794774Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f19dfbf3-85a6-4039-9401-cd19548f4bab] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-20T21:18:45.217505483Z 21:18:45 default_worker.1     | INFO  2025-10-20T21:18:45.204Z pid=302 tid=hnq jid=bd9880b45ccbc1f81dfd3cb6 class=Upgrade::FixParentCollections elapsed=0.506: done
2025-10-20T21:18:45.376337351Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f19dfbf3-85a6-4039-9401-cd19548f4bab] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-20T21:18:45.379643617Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f19dfbf3-85a6-4039-9401-cd19548f4bab] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.159
2025-10-20T21:18:45.397831775Z 21:18:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f19dfbf3-85a6-4039-9401-cd19548f4bab] Performed Upgrade::PruneOrphanedProblems (Job ID: f19dfbf3-85a6-4039-9401-cd19548f4bab) from Sidekiq(upgrade) in 210.26ms
2025-10-20T21:18:45.399442768Z 21:18:45 default_worker.1     | INFO  2025-10-20T21:18:45.398Z pid=302 tid=hoe jid=f33a29ef939bc1bc8c9ba103 class=Upgrade::PruneOrphanedProblems elapsed=0.241: done
2025-10-20T21:19:09.619403964Z 21:19:09 rails.1              | [3e9f6c66-fe8c-4f8e-94f2-30126c9fa8b8] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1390,"duration":32.17,"view":0.0,"db":4.89,"@timestamp":"2025-10-20T21:19:09.618Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-20T21:19:10.596475925Z 21:19:10 rails.1              | [521c0cba-f770-464f-9e63-8bda3fa38f1c] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":84236,"duration":953.53,"view":0.0,"db":26.19,"location":"http://172.17.0.4:3214/","@timestamp":"2025-10-20T21:19:10.595Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-20T21:19:10.679532448Z 21:19:10 rails.1              | [2756830b-c09b-4223-b20b-aa17ee85385f] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1078,"duration":52.64,"view":0.0,"db":3.08,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-10-20T21:19:10.661Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-20T21:19:11.448086460Z 21:19:11 rails.1              | [1dca334f-5b64-4f34-b0ae-ecf5759990cb] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24004,"duration":737.03,"view":592.58,"db":65.52,"@timestamp":"2025-10-20T21:19:11.446Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-10-20T21:19:11.508333764Z 21:19:11 rails.1              | [598da517-f713-4169-9d2c-969430bffdbc] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1178,"duration":21.79,"view":0.0,"db":3.29,"@timestamp":"2025-10-20T21:19:11.506Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-20T21:19:11.807930948Z 21:19:11 rails.1              | [df6b2ba5-5e1a-489b-8824-1e8ee2231942] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14473,"duration":219.36,"view":0.0,"db":1.66,"location":"http://172.17.0.4:3214/","@timestamp":"2025-10-20T21:19:11.807Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-20T21:19:11.917684790Z 21:19:11 rails.1              | [7e136d63-8e51-4858-908c-7b68bb4146ed] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1099,"duration":44.34,"view":0.0,"db":4.06,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-10-20T21:19:11.870Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-20T21:19:12.315544311Z 21:19:12 rails.1              | [a41d5877-d15f-41d8-824a-66edfad0ae96] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24202,"duration":364.74,"view":233.21,"db":1.34,"@timestamp":"2025-10-20T21:19:12.310Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}