2025-10-16T09:59:59.407622390Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-10-16T09:59:59.407801540Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-10-16T09:59:59.567486471Z [mod-init] Running Docker Modification Logic
2025-10-16T09:59:59.820411181Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-10-16T10:00:00.730456981Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-10-16T10:00:01.302143409Z [mod-init] Installing linuxserver/mods:universal-redis
2025-10-16T10:00:01.324836426Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-10-16T10:00:01.325861009Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-10-16T10:00:01.347274951Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-10-16T10:00:01.377879818Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-10-16T10:00:01.378074109Z s6-rc: info: service fix-attrs: starting
2025-10-16T10:00:01.378325555Z s6-rc: info: service init-migrations: starting
2025-10-16T10:00:01.378629086Z s6-rc: info: service init-envfile: starting
2025-10-16T10:00:01.386071490Z [migrations] started
2025-10-16T10:00:01.386147563Z [migrations] no migrations found
2025-10-16T10:00:01.387500968Z s6-rc: info: service fix-attrs successfully started
2025-10-16T10:00:01.387713466Z s6-rc: info: service legacy-cont-init: starting
2025-10-16T10:00:01.389679564Z s6-rc: info: service init-migrations successfully started
2025-10-16T10:00:01.389799776Z s6-rc: info: service init-adduser: starting
2025-10-16T10:00:01.391735453Z s6-rc: info: service init-envfile successfully started
2025-10-16T10:00:01.393948499Z s6-rc: info: service legacy-cont-init successfully started
2025-10-16T10:00:01.478623694Z usermod: no changes
2025-10-16T10:00:01.484494604Z ───────────────────────────────────────
2025-10-16T10:00:01.484508882Z 
2025-10-16T10:00:01.484513592Z       ██╗     ███████╗██╗ ██████╗
2025-10-16T10:00:01.484517750Z       ██║     ██╔════╝██║██╔═══██╗
2025-10-16T10:00:01.484521638Z       ██║     ███████╗██║██║   ██║
2025-10-16T10:00:01.484525516Z       ██║     ╚════██║██║██║   ██║
2025-10-16T10:00:01.484529504Z       ███████╗███████║██║╚██████╔╝
2025-10-16T10:00:01.484533342Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-10-16T10:00:01.484537480Z 
2025-10-16T10:00:01.484541468Z    Brought to you by linuxserver.io
2025-10-16T10:00:01.484553392Z ───────────────────────────────────────
2025-10-16T10:00:01.484879970Z 
2025-10-16T10:00:01.484899559Z To support LSIO projects visit:
2025-10-16T10:00:01.484904349Z https://www.linuxserver.io/donate/
2025-10-16T10:00:01.484908246Z 
2025-10-16T10:00:01.484911944Z ───────────────────────────────────────
2025-10-16T10:00:01.484916323Z GID/UID
2025-10-16T10:00:01.484920541Z ───────────────────────────────────────
2025-10-16T10:00:01.490381746Z 
2025-10-16T10:00:01.490406155Z User UID:    911
2025-10-16T10:00:01.490415574Z User GID:    911
2025-10-16T10:00:01.490423931Z ───────────────────────────────────────
2025-10-16T10:00:01.492177712Z Linuxserver.io version: v0.126.0-ls109
2025-10-16T10:00:01.492443297Z Build-date: 2025-10-16T09:47:44+00:00
2025-10-16T10:00:01.492449108Z ───────────────────────────────────────
2025-10-16T10:00:01.492453798Z     
2025-10-16T10:00:01.507949746Z s6-rc: info: service init-adduser successfully started
2025-10-16T10:00:01.508189328Z s6-rc: info: service init-device-perms: starting
2025-10-16T10:00:01.516131157Z s6-rc: info: service init-device-perms successfully started
2025-10-16T10:00:01.516375950Z s6-rc: info: service init-os-end: starting
2025-10-16T10:00:01.517754946Z s6-rc: info: service init-os-end successfully started
2025-10-16T10:00:01.517989418Z s6-rc: info: service init-manyfold-config: starting
2025-10-16T10:00:01.518230694Z s6-rc: info: service init-config: starting
2025-10-16T10:00:01.520242624Z s6-rc: info: service init-config successfully started
2025-10-16T10:00:01.520478419Z s6-rc: info: service init-crontab-config: starting
2025-10-16T10:00:01.523276052Z **** SECRET_KEY_BASE set in environment. ****
2025-10-16T10:00:01.535016128Z s6-rc: info: service init-crontab-config successfully started
2025-10-16T10:00:01.547613550Z **** Running Manyfold database init. ****
2025-10-16T10:00:03.849974129Z `/root` is not writable.
2025-10-16T10:00:03.850142488Z Bundler will use `/tmp/bundler20251016-173-3mcek4173' as your home directory temporarily.
2025-10-16T10:00:10.998910942Z Server: bce9365d53e0, Context: rails, Role: web, data: {cpu: {one_min: 6.25, five_min: 3.13, fifteen_min: 2.47}, memory: 0.21669888e9, disk: {available: 830614388736, total: 938656133120, used: 108041744384}}
2025-10-16T10:00:10.998966093Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-10-16T10:00:10.998975953Z INFO  2025-10-16T10:00:09.150Z pid=173 tid=2id: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-16T10:00:10.999006455Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.default_viewer_role` fallback to returns the default value.
2025-10-16T10:00:10.999015403Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-10-16T10:00:10.999024110Z Migrating to CreateLibraries (20210130201037)
2025-10-16T10:00:10.999032417Z == 20210130201037 CreateLibraries: migrating ==================================
2025-10-16T10:00:10.999040683Z -- create_table(:libraries)
2025-10-16T10:00:10.999048760Z    -> 0.0030s
2025-10-16T10:00:10.999056986Z == 20210130201037 CreateLibraries: migrated (0.0030s) =========================
2025-10-16T10:00:10.999065113Z 
2025-10-16T10:00:10.999073009Z Migrating to CreateModels (20210130203243)
2025-10-16T10:00:10.999081155Z == 20210130203243 CreateModels: migrating =====================================
2025-10-16T10:00:10.999089311Z -- create_table(:models)
2025-10-16T10:00:10.999097478Z    -> 0.0010s
2025-10-16T10:00:10.999105644Z == 20210130203243 CreateModels: migrated (0.0011s) ============================
2025-10-16T10:00:10.999113811Z 
2025-10-16T10:00:10.999121847Z Migrating to CreateParts (20210205230918)
2025-10-16T10:00:10.999129813Z == 20210205230918 CreateParts: migrating ======================================
2025-10-16T10:00:10.999137919Z -- create_table(:parts)
2025-10-16T10:00:10.999146046Z    -> 0.0034s
2025-10-16T10:00:10.999154322Z == 20210205230918 CreateParts: migrated (0.0034s) =============================
2025-10-16T10:00:10.999162659Z 
2025-10-16T10:00:10.999170565Z Migrating to AddFieldsToParts (20210210153744)
2025-10-16T10:00:10.999179022Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-10-16T10:00:10.999187118Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-10-16T10:00:10.999195245Z    -> 0.0008s
2025-10-16T10:00:10.999203161Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-10-16T10:00:10.999211307Z    -> 0.0003s
2025-10-16T10:00:10.999219393Z == 20210210153744 AddFieldsToParts: migrated (0.0012s) ========================
2025-10-16T10:00:10.999227540Z 
2025-10-16T10:00:10.999235385Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-10-16T10:00:10.999243732Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-10-16T10:00:10.999252159Z -- create_table(:tags, {id: :integer})
2025-10-16T10:00:10.999260516Z    -> 0.0038s
2025-10-16T10:00:10.999269845Z -- create_table(:taggings, {id: :integer})
2025-10-16T10:00:10.999287921Z    -> 0.0017s
2025-10-16T10:00:10.999296438Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-16T10:00:10.999304785Z    -> 0.0002s
2025-10-16T10:00:10.999312711Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-16T10:00:10.999321118Z    -> 0.0021s
2025-10-16T10:00:10.999329014Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0080s) ===============
2025-10-16T10:00:10.999337100Z 
2025-10-16T10:00:10.999344946Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-10-16T10:00:10.999352962Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-10-16T10:00:10.999361099Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-10-16T10:00:10.999369315Z    -> 0.0003s
2025-10-16T10:00:10.999377181Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-16T10:00:10.999385548Z    -> 0.0004s
2025-10-16T10:00:10.999393564Z -- remove_foreign_key(:taggings, :tags)
2025-10-16T10:00:10.999401530Z    -> 0.1612s
2025-10-16T10:00:10.999409486Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-16T10:00:10.999417662Z    -> 0.0143s
2025-10-16T10:00:10.999425598Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-10-16T10:00:10.999433765Z    -> 0.0002s
2025-10-16T10:00:10.999441671Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-10-16T10:00:10.999450158Z    -> 0.0046s
2025-10-16T10:00:10.999458054Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-10-16T10:00:10.999466300Z    -> 0.0754s
2025-10-16T10:00:10.999474357Z == 20210212143002 AddMissingUniqueIndices: migrated (0.2862s) =================
2025-10-16T10:00:10.999482533Z 
2025-10-16T10:00:10.999490659Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-10-16T10:00:10.999498656Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-10-16T10:00:10.999506682Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-10-16T10:00:10.999514708Z    -> 0.0382s
2025-10-16T10:00:10.999522564Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1183s) ===========
2025-10-16T10:00:10.999530640Z 
2025-10-16T10:00:10.999538416Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-10-16T10:00:10.999546442Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-10-16T10:00:10.999554598Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-16T10:00:10.999572815Z    -> 0.0003s
2025-10-16T10:00:10.999580731Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0004s) =================
2025-10-16T10:00:10.999588787Z 
2025-10-16T10:00:10.999596523Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-10-16T10:00:10.999604619Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-10-16T10:00:10.999612815Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0007s) ==============
2025-10-16T10:00:10.999621022Z 
2025-10-16T10:00:10.999630150Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-10-16T10:00:10.999638467Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-10-16T10:00:10.999646533Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-16T10:00:10.999654720Z    -> 0.0080s
2025-10-16T10:00:10.999662626Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-16T10:00:10.999670762Z    -> 0.0002s
2025-10-16T10:00:10.999678648Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-16T10:00:10.999686814Z    -> 0.0055s
2025-10-16T10:00:10.999694921Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-16T10:00:10.999703077Z    -> 0.0012s
2025-10-16T10:00:10.999710953Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-16T10:00:10.999719260Z    -> 0.0004s
2025-10-16T10:00:10.999727196Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-16T10:00:10.999735372Z    -> 0.0001s
2025-10-16T10:00:10.999743318Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-16T10:00:10.999751545Z    -> 0.0037s
2025-10-16T10:00:10.999759741Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-16T10:00:10.999768118Z    -> 0.0002s
2025-10-16T10:00:10.999776114Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-16T10:00:10.999784351Z    -> 0.0005s
2025-10-16T10:00:10.999792357Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-16T10:00:10.999800573Z    -> 0.0001s
2025-10-16T10:00:10.999808549Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-16T10:00:10.999817327Z    -> 0.0006s
2025-10-16T10:00:10.999825273Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-16T10:00:10.999833630Z    -> 0.0001s
2025-10-16T10:00:10.999867488Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-16T10:00:10.999878631Z    -> 0.0015s
2025-10-16T10:00:10.999886557Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-16T10:00:10.999894773Z    -> 0.0002s
2025-10-16T10:00:10.999902669Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0227s) =============
2025-10-16T10:00:10.999910825Z 
2025-10-16T10:00:10.999918771Z Migrating to AddPreviewPartToModel (20210220204055)
2025-10-16T10:00:10.999926998Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-10-16T10:00:10.999935104Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-10-16T10:00:10.999943311Z    -> 0.2395s
2025-10-16T10:00:10.999951277Z == 20210220204055 AddPreviewPartToModel: migrated (0.2395s) ===================
2025-10-16T10:00:10.999959493Z 
2025-10-16T10:00:10.999967329Z Migrating to CreateCreators (20210225232756)
2025-10-16T10:00:10.999975295Z == 20210225232756 CreateCreators: migrating ===================================
2025-10-16T10:00:10.999984113Z -- create_table(:creators)
2025-10-16T10:00:10.999992209Z    -> 0.0148s
2025-10-16T10:00:11.000000155Z == 20210225232756 CreateCreators: migrated (0.0148s) ==========================
2025-10-16T10:00:11.000008532Z 
2025-10-16T10:00:11.000016638Z Migrating to AddCreatorToModels (20210225232841)
2025-10-16T10:00:11.000024735Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-10-16T10:00:11.000032931Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-10-16T10:00:11.000041358Z    -> 0.0506s
2025-10-16T10:00:11.000049545Z == 20210225232841 AddCreatorToModels: migrated (0.0506s) ======================
2025-10-16T10:00:11.000058222Z 
2025-10-16T10:00:11.000066178Z Migrating to CreateLinks (20210301230017)
2025-10-16T10:00:11.000074234Z == 20210301230017 CreateLinks: migrating ======================================
2025-10-16T10:00:11.000082471Z -- create_table(:links)
2025-10-16T10:00:11.000090677Z    -> 0.0009s
2025-10-16T10:00:11.000098654Z == 20210301230017 CreateLinks: migrated (0.0009s) =============================
2025-10-16T10:00:11.000106750Z 
2025-10-16T10:00:11.000114706Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-10-16T10:00:11.000122772Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-10-16T10:00:11.000130808Z -- remove_column(:creators, :thingiverse_user, :string)
2025-10-16T10:00:11.000138794Z    -> 0.0621s
2025-10-16T10:00:11.000146680Z -- remove_column(:creators, :cults3d_user, :string)
2025-10-16T10:00:11.000163855Z    -> 0.0042s
2025-10-16T10:00:11.000171791Z -- remove_column(:creators, :mmf_user, :string)
2025-10-16T10:00:11.000179747Z    -> 0.0133s
2025-10-16T10:00:11.000187703Z -- remove_column(:creators, :cgtrader_user, :string)
2025-10-16T10:00:11.000195739Z    -> 0.0037s
2025-10-16T10:00:11.000203625Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0854s) ==============
2025-10-16T10:00:11.000211902Z 
2025-10-16T10:00:11.000219757Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-10-16T10:00:11.000227984Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-10-16T10:00:11.000236110Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-10-16T10:00:11.000244177Z    -> 0.0537s
2025-10-16T10:00:11.000252253Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0537s) ==
2025-10-16T10:00:11.000260329Z 
2025-10-16T10:00:11.000268055Z Migrating to AddYUpToParts (20210318202638)
2025-10-16T10:00:11.000276001Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-10-16T10:00:11.000284017Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-10-16T10:00:11.000292063Z    -> 0.0141s
2025-10-16T10:00:11.000299949Z == 20210318202638 AddYUpToParts: migrated (0.0142s) ===========================
2025-10-16T10:00:11.000308025Z 
2025-10-16T10:00:11.000316081Z Migrating to CreateImages (20210321164508)
2025-10-16T10:00:11.000324007Z == 20210321164508 CreateImages: migrating =====================================
2025-10-16T10:00:11.000332244Z -- create_table(:images)
2025-10-16T10:00:11.000340390Z    -> 0.0157s
2025-10-16T10:00:11.000348396Z == 20210321164508 CreateImages: migrated (0.0157s) ============================
2025-10-16T10:00:11.000356523Z 
2025-10-16T10:00:11.000364389Z Migrating to CreateDelayedJobs (20210330215825)
2025-10-16T10:00:11.707694178Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-10-16T10:00:11.707731393Z -- create_table(:delayed_jobs)
2025-10-16T10:00:11.707740902Z    -> 0.0086s
2025-10-16T10:00:11.707749519Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-10-16T10:00:11.707758197Z    -> 0.0002s
2025-10-16T10:00:11.707766904Z == 20210330215825 CreateDelayedJobs: migrated (0.0088s) =======================
2025-10-16T10:00:11.707775091Z 
2025-10-16T10:00:11.707783047Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-10-16T10:00:11.707791273Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-10-16T10:00:11.707814630Z -- rename_table(:parts, :model_files)
2025-10-16T10:00:11.707822927Z    -> 0.0017s
2025-10-16T10:00:11.707830923Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-10-16T10:00:11.707839110Z    -> 0.0333s
2025-10-16T10:00:11.707883569Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0351s) =================
2025-10-16T10:00:11.707894992Z 
2025-10-16T10:00:11.707902978Z Migrating to RemoveImagesTable (20220106220519)
2025-10-16T10:00:11.707911285Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-10-16T10:00:11.707919522Z -- drop_table(:images)
2025-10-16T10:00:11.707927558Z    -> 0.0003s
2025-10-16T10:00:11.707935484Z == 20220106220519 RemoveImagesTable: migrated (0.0003s) =======================
2025-10-16T10:00:11.707943901Z 
2025-10-16T10:00:11.707951726Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-10-16T10:00:11.707959793Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-10-16T10:00:11.707967889Z -- table_exists?(:active_storage_blobs)
2025-10-16T10:00:11.707975995Z    -> 0.0001s
2025-10-16T10:00:11.707984152Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-10-16T10:00:11.707992448Z 
2025-10-16T10:00:11.708000444Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-10-16T10:00:11.708008651Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-10-16T10:00:11.708016918Z -- table_exists?(:active_storage_blobs)
2025-10-16T10:00:11.708025084Z    -> 0.0001s
2025-10-16T10:00:11.708033190Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-10-16T10:00:11.708041557Z 
2025-10-16T10:00:11.708049413Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-10-16T10:00:11.708057920Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-10-16T10:00:11.708066117Z -- table_exists?(:active_storage_blobs)
2025-10-16T10:00:11.708074534Z    -> 0.0001s
2025-10-16T10:00:11.708082510Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-10-16T10:00:11.708090656Z 
2025-10-16T10:00:11.708098622Z Migrating to DeviseCreateUsers (20220614210023)
2025-10-16T10:00:11.708107059Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-10-16T10:00:11.708115125Z -- create_table(:users)
2025-10-16T10:00:11.708123021Z    -> 0.0012s
2025-10-16T10:00:11.708130907Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-10-16T10:00:11.708139074Z    -> 0.0015s
2025-10-16T10:00:11.708157330Z == 20220614210023 DeviseCreateUsers: migrated (0.0027s) =======================
2025-10-16T10:00:11.708165517Z 
2025-10-16T10:00:11.708173272Z Migrating to AddUsernameToUsers (20220614211256)
2025-10-16T10:00:11.708182832Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-10-16T10:00:11.708191199Z -- add_column(:users, :username, :string, {null: false})
2025-10-16T10:00:11.708199205Z    -> 0.0229s
2025-10-16T10:00:11.708207121Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-10-16T10:00:11.708215347Z    -> 0.0002s
2025-10-16T10:00:11.708223273Z == 20220614211256 AddUsernameToUsers: migrated (0.0231s) ======================
2025-10-16T10:00:11.708231570Z 
2025-10-16T10:00:11.708239365Z Migrating to AddAdminToUsers (20220614213902)
2025-10-16T10:00:11.708247402Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-10-16T10:00:11.708255408Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-16T10:00:11.708263464Z    -> 0.0005s
2025-10-16T10:00:11.708271370Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-10-16T10:00:11.708279436Z 
2025-10-16T10:00:11.708287202Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-10-16T10:00:11.708295168Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-10-16T10:00:11.708303214Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-10-16T10:00:11.708312593Z    -> 0.0012s
2025-10-16T10:00:11.708320569Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0012s) =============
2025-10-16T10:00:11.708328595Z 
2025-10-16T10:00:11.708336331Z Migrating to CreateSettings (20220619174307)
2025-10-16T10:00:11.708344267Z == 20220619174307 CreateSettings: migrating ===================================
2025-10-16T10:00:11.708352774Z -- create_table(:settings)
2025-10-16T10:00:11.708360650Z    -> 0.0026s
2025-10-16T10:00:11.708368576Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-10-16T10:00:11.708376852Z    -> 0.0002s
2025-10-16T10:00:11.708384808Z == 20220619174307 CreateSettings: migrated (0.0028s) ==========================
2025-10-16T10:00:11.708393115Z 
2025-10-16T10:00:11.708401091Z Migrating to AddScaleFactorToModels (20220626152444)
2025-10-16T10:00:11.708409087Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-10-16T10:00:11.708417264Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-10-16T10:00:11.708425570Z    -> 0.0102s
2025-10-16T10:00:11.708443446Z == 20220626152444 AddScaleFactorToModels: migrated (0.0124s) ==================
2025-10-16T10:00:11.708451643Z 
2025-10-16T10:00:11.708459769Z Migrating to AddDigestToModelFiles (20220702202932)
2025-10-16T10:00:11.708468006Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-10-16T10:00:11.708476443Z -- add_column(:model_files, :digest, :string)
2025-10-16T10:00:11.708484339Z    -> 0.0023s
2025-10-16T10:00:11.708492255Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-10-16T10:00:11.708500431Z    -> 0.0002s
2025-10-16T10:00:11.708508287Z == 20220702202932 AddDigestToModelFiles: migrated (0.0044s) ===================
2025-10-16T10:00:11.708516353Z 
2025-10-16T10:00:11.708524510Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-10-16T10:00:11.708532556Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-10-16T10:00:11.708540652Z -- 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-16T10:00:11.708552957Z    -> 0.0011s
2025-10-16T10:00:11.708562586Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0015s) ==============
2025-10-16T10:00:11.708570723Z 
2025-10-16T10:00:11.708578739Z Migrating to CreateProblems (20221210001132)
2025-10-16T10:00:11.708586975Z == 20221210001132 CreateProblems: migrating ===================================
2025-10-16T10:00:11.708594971Z -- create_table(:problems)
2025-10-16T10:00:11.708603098Z    -> 0.0009s
2025-10-16T10:00:11.708611124Z == 20221210001132 CreateProblems: migrated (0.0012s) ==========================
2025-10-16T10:00:11.708619351Z 
2025-10-16T10:00:11.708627056Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-10-16T10:00:11.708635032Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-10-16T10:00:11.708643178Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0163s) ========
2025-10-16T10:00:11.708651245Z 
2025-10-16T10:00:11.708659010Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-10-16T10:00:11.708667037Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-10-16T10:00:11.708675053Z -- create_table(:favorites, {force: true})
2025-10-16T10:00:11.708682919Z    -> 0.0040s
2025-10-16T10:00:11.708690774Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-10-16T10:00:11.708699312Z    -> 0.0001s
2025-10-16T10:00:11.708707177Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-10-16T10:00:11.708724763Z    -> 0.0001s
2025-10-16T10:00:11.708732779Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-10-16T10:00:11.708741807Z    -> 0.0001s
2025-10-16T10:00:11.708749663Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0048s) ================
2025-10-16T10:00:11.708757719Z 
2025-10-16T10:00:11.708765715Z Migrating to MovePrintedToFavorites (20221220223040)
2025-10-16T10:00:11.708773741Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-10-16T10:00:11.708783832Z == 20221220223040 MovePrintedToFavorites: migrated (0.0605s) ==================
2025-10-16T10:00:11.708791978Z 
2025-10-16T10:00:11.708799874Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-10-16T10:00:11.708808010Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-10-16T10:00:11.708816207Z -- remove_column(:model_files, :printed, :boolean)
2025-10-16T10:00:11.708824393Z    -> 0.0273s
2025-10-16T10:00:11.708833071Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0277s) ===============
2025-10-16T10:00:11.708841277Z 
2025-10-16T10:00:11.708849283Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-10-16T10:00:11.708857851Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-10-16T10:00:11.708866027Z -- add_column(:models, :notes, :text)
2025-10-16T10:00:11.708875005Z    -> 0.0012s
2025-10-16T10:00:11.708883001Z -- add_column(:models, :excerpt, :text)
2025-10-16T10:00:11.708891148Z    -> 0.0024s
2025-10-16T10:00:11.708899304Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0036s) =================
2025-10-16T10:00:11.708907631Z 
2025-10-16T10:00:11.708915417Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-10-16T10:00:11.708923783Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-10-16T10:00:11.708931800Z -- add_column(:creators, :notes, :text)
2025-10-16T10:00:11.708939826Z    -> 0.0006s
2025-10-16T10:00:11.708947752Z -- add_column(:creators, :excerpt, :text)
2025-10-16T10:00:11.708955668Z    -> 0.0005s
2025-10-16T10:00:11.708963574Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0011s) ===============
2025-10-16T10:00:11.708971640Z 
2025-10-16T10:00:11.708979425Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-10-16T10:00:11.708987472Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-10-16T10:00:11.708995808Z -- add_column(:model_files, :notes, :text)
2025-10-16T10:00:11.709013063Z    -> 0.0006s
2025-10-16T10:00:11.709021029Z -- add_column(:model_files, :excerpt, :text)
2025-10-16T10:00:11.709028985Z    -> 0.0005s
2025-10-16T10:00:11.709036901Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0018s) =============
2025-10-16T10:00:11.709044917Z 
2025-10-16T10:00:11.709052653Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-10-16T10:00:11.709061030Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-10-16T10:00:11.709069106Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0203s) =================
2025-10-16T10:00:11.709077333Z 
2025-10-16T10:00:11.709085349Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-10-16T10:00:11.709093335Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-10-16T10:00:11.709101321Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-10-16T10:00:11.709110048Z    -> 0.0453s
2025-10-16T10:00:11.709117904Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0454s) =============
2025-10-16T10:00:11.709126011Z 
2025-10-16T10:00:11.709133766Z Migrating to RenameExcerptToCaption (20230222155910)
2025-10-16T10:00:11.709141702Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-10-16T10:00:11.709149738Z -- rename_column(:creators, :excerpt, :caption)
2025-10-16T10:00:11.709157654Z    -> 0.0240s
2025-10-16T10:00:11.709165580Z -- rename_column(:models, :excerpt, :caption)
2025-10-16T10:00:11.709173677Z    -> 0.0210s
2025-10-16T10:00:11.709181582Z -- rename_column(:model_files, :excerpt, :caption)
2025-10-16T10:00:11.709189619Z    -> 0.0191s
2025-10-16T10:00:11.709197555Z == 20230222155910 RenameExcerptToCaption: migrated (0.0668s) ==================
2025-10-16T10:00:11.709205831Z 
2025-10-16T10:00:11.709213587Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-10-16T10:00:12.139901135Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-10-16T10:00:12.139941667Z -- add_column(:libraries, :notes, :string)
2025-10-16T10:00:12.139950996Z    -> 0.0020s
2025-10-16T10:00:12.139959854Z -- add_column(:libraries, :caption, :string)
2025-10-16T10:00:12.139968060Z    -> 0.0005s
2025-10-16T10:00:12.139976537Z -- add_column(:libraries, :name, :string)
2025-10-16T10:00:12.139984894Z    -> 0.0005s
2025-10-16T10:00:12.139993421Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0114s) ============
2025-10-16T10:00:12.140001628Z 
2025-10-16T10:00:12.140009464Z Migrating to AddTagregexToLibrary (20230305180823)
2025-10-16T10:00:12.140044574Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-10-16T10:00:12.140053753Z -- add_column(:libraries, :tag_regex, :text)
2025-10-16T10:00:12.140061729Z    -> 0.0020s
2025-10-16T10:00:12.140070336Z == 20230305180823 AddTagregexToLibrary: migrated (0.0036s) ====================
2025-10-16T10:00:12.140078973Z 
2025-10-16T10:00:12.140086899Z Migrating to AddIconToLibrary (20230307215826)
2025-10-16T10:00:12.140095176Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-10-16T10:00:12.140104064Z -- add_column(:libraries, :icon, :text)
2025-10-16T10:00:12.140112210Z    -> 0.0019s
2025-10-16T10:00:12.140120828Z == 20230307215826 AddIconToLibrary: migrated (0.0035s) ========================
2025-10-16T10:00:12.140129275Z 
2025-10-16T10:00:12.140137571Z Migrating to CreateCollection (20230308004237)
2025-10-16T10:00:12.140145888Z == 20230308004237 CreateCollection: migrating =================================
2025-10-16T10:00:12.140154175Z -- create_table(:collections)
2025-10-16T10:00:12.140162101Z    -> 0.0029s
2025-10-16T10:00:12.140170067Z == 20230308004237 CreateCollection: migrated (0.0067s) ========================
2025-10-16T10:00:12.140178123Z 
2025-10-16T10:00:12.140186269Z Migrating to AddCollectionToModels (20230308005021)
2025-10-16T10:00:12.140194426Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-10-16T10:00:12.140202703Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-10-16T10:00:12.140210809Z    -> 0.0181s
2025-10-16T10:00:12.140218705Z == 20230308005021 AddCollectionToModels: migrated (0.0216s) ===================
2025-10-16T10:00:12.140226761Z 
2025-10-16T10:00:12.140234837Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-10-16T10:00:12.140242843Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-10-16T10:00:12.140250960Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0014s) =============
2025-10-16T10:00:12.140259046Z 
2025-10-16T10:00:12.140266822Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-10-16T10:00:12.140274838Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-10-16T10:00:12.140282944Z -- rename_column(:collections, :excerpt, :caption)
2025-10-16T10:00:12.140291151Z    -> 0.0044s
2025-10-16T10:00:12.140299227Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0044s) ========
2025-10-16T10:00:12.140307474Z 
2025-10-16T10:00:12.140315710Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-10-16T10:00:12.140323897Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-10-16T10:00:12.140349789Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-10-16T10:00:12.140358055Z 
2025-10-16T10:00:12.140366883Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-10-16T10:00:12.140374869Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-10-16T10:00:12.140383747Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-10-16T10:00:12.140393938Z    -> 0.0016s
2025-10-16T10:00:12.140402134Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0017s) ===============
2025-10-16T10:00:12.140414409Z 
2025-10-16T10:00:12.140426794Z Migrating to AddCollectionToCollections (20230324000000)
2025-10-16T10:00:12.140435642Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-10-16T10:00:12.140446213Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-10-16T10:00:12.140456584Z    -> 0.0066s
2025-10-16T10:00:12.140468217Z == 20230324000000 AddCollectionToCollections: migrated (0.0087s) ==============
2025-10-16T10:00:12.140476945Z 
2025-10-16T10:00:12.140488698Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-10-16T10:00:12.140497596Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-10-16T10:00:12.140508368Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0455s) =========
2025-10-16T10:00:12.140516965Z 
2025-10-16T10:00:12.140525252Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-10-16T10:00:12.140533739Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-10-16T10:00:12.140541805Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0065s) 
2025-10-16T10:00:12.140550162Z 
2025-10-16T10:00:12.140558248Z Migrating to AddSlugs (20230615135601)
2025-10-16T10:00:12.140566114Z == 20230615135601 AddSlugs: migrating =========================================
2025-10-16T10:00:12.140574160Z -- add_column(:models, :slug, :string)
2025-10-16T10:00:12.140582076Z    -> 0.0029s
2025-10-16T10:00:12.140589932Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-10-16T10:00:12.140598429Z    -> 0.0019s
2025-10-16T10:00:12.140606255Z -- add_column(:collections, :slug, :string)
2025-10-16T10:00:12.140614181Z    -> 0.0005s
2025-10-16T10:00:12.140622107Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-10-16T10:00:12.140630654Z    -> 0.0001s
2025-10-16T10:00:12.140639001Z -- add_column(:creators, :slug, :string)
2025-10-16T10:00:12.140657729Z    -> 0.0005s
2025-10-16T10:00:12.140666266Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-10-16T10:00:12.140674773Z    -> 0.0001s
2025-10-16T10:00:12.140682559Z == 20230615135601 AddSlugs: migrated (0.0065s) ================================
2025-10-16T10:00:12.140690916Z 
2025-10-16T10:00:12.140699012Z Migrating to GenerateSlugs (20230617222353)
2025-10-16T10:00:12.140706938Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-10-16T10:00:12.140714984Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-10-16T10:00:12.140723221Z 
2025-10-16T10:00:12.140731207Z Migrating to MakeNamesUnique (20230628194944)
2025-10-16T10:00:12.140739824Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-10-16T10:00:12.140748311Z == 20230628194944 MakeNamesUnique: migrated (0.0030s) =========================
2025-10-16T10:00:12.140756588Z 
2025-10-16T10:00:12.140764644Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-10-16T10:00:12.140772810Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-10-16T10:00:12.140781037Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-10-16T10:00:12.140789664Z    -> 0.0020s
2025-10-16T10:00:12.140798402Z -- remove_index(:creators, :slug)
2025-10-16T10:00:12.140806779Z    -> 0.0004s
2025-10-16T10:00:12.140814785Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-10-16T10:00:12.140824645Z    -> 0.0001s
2025-10-16T10:00:12.140833863Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-10-16T10:00:12.140845146Z    -> 0.0001s
2025-10-16T10:00:12.140853353Z -- remove_index(:collections, :slug)
2025-10-16T10:00:12.140863864Z    -> 0.0230s
2025-10-16T10:00:12.140872772Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-10-16T10:00:12.140882722Z    -> 0.0006s
2025-10-16T10:00:12.140893213Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0266s) ======
2025-10-16T10:00:12.140902361Z 
2025-10-16T10:00:12.140912772Z Migrating to AddSizeToModelFiles (20230707082403)
2025-10-16T10:00:12.140923834Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-10-16T10:00:12.140936500Z -- add_column(:model_files, :size, :integer)
2025-10-16T10:00:12.140947422Z    -> 0.0008s
2025-10-16T10:00:12.140956069Z == 20230707082403 AddSizeToModelFiles: migrated (0.0011s) =====================
2025-10-16T10:00:12.140964156Z 
2025-10-16T10:00:12.140981681Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-10-16T10:00:12.140989707Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-10-16T10:00:12.140997793Z -- change_column(:model_files, :size, :bigint)
2025-10-16T10:00:12.141005709Z    -> 0.0083s
2025-10-16T10:00:12.141013625Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0086s) ==================
2025-10-16T10:00:12.141021601Z 
2025-10-16T10:00:12.141033445Z Migrating to AddNoteToProblems (20230711111009)
2025-10-16T10:00:12.141044708Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-10-16T10:00:12.141055239Z -- add_column(:problems, :note, :string, {default: nil})
2025-10-16T10:00:12.141065951Z    -> 0.0012s
2025-10-16T10:00:12.141078145Z == 20230711111009 AddNoteToProblems: migrated (0.0022s) =======================
2025-10-16T10:00:12.141087103Z 
2025-10-16T10:00:12.141097073Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-10-16T10:00:12.141107635Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-10-16T10:00:12.141122074Z -- 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-16T10:00:12.141137926Z    -> 0.0006s
2025-10-16T10:00:12.141146513Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-10-16T10:00:12.141157745Z 
2025-10-16T10:00:12.141168818Z Migrating to AddLicenseToModel (20240127143358)
2025-10-16T10:00:12.141180381Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-10-16T10:00:12.141191103Z -- add_column(:models, :license, :string)
2025-10-16T10:00:12.141201894Z    -> 0.0006s
2025-10-16T10:00:12.141212796Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-10-16T10:00:12.141225311Z 
2025-10-16T10:00:12.141233708Z Migrating to AddIgnoredToProblems (20240131134832)
2025-10-16T10:00:12.141241704Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-10-16T10:00:12.141250192Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-10-16T10:00:12.141258238Z    -> 0.0006s
2025-10-16T10:00:12.141266174Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-10-16T10:00:12.141276284Z 
2025-10-16T10:00:12.141285092Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-10-16T10:00:12.141307978Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-10-16T10:00:12.141320954Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-10-16T10:00:12.141329762Z    -> 0.0096s
2025-10-16T10:00:12.141340734Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0097s) ======
2025-10-16T10:00:12.141351195Z 
2025-10-16T10:00:12.141361305Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-10-16T10:00:12.141371937Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-10-16T10:00:12.141382839Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-10-16T10:00:12.141393951Z    -> 0.0006s
2025-10-16T10:00:12.141402208Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-10-16T10:00:12.141410274Z 
2025-10-16T10:00:12.141418380Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-10-16T10:00:12.141426366Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-10-16T10:00:12.141434663Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-10-16T10:00:12.141442879Z    -> 0.0002s
2025-10-16T10:00:12.141450765Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-10-16T10:00:12.141459092Z    -> 0.0009s
2025-10-16T10:00:12.141466988Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-10-16T10:00:12.141475585Z    -> 0.0001s
2025-10-16T10:00:12.695772766Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-10-16T10:00:12.695817636Z    -> 0.0045s
2025-10-16T10:00:12.695827556Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0059s) =================
2025-10-16T10:00:12.695836133Z 
2025-10-16T10:00:12.695858729Z Migrating to CreateFlipperTables (20240306095646)
2025-10-16T10:00:12.695870112Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-10-16T10:00:12.695878689Z -- create_table(:flipper_features)
2025-10-16T10:00:12.695887186Z    -> 0.0029s
2025-10-16T10:00:12.695895353Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-10-16T10:00:12.695904080Z    -> 0.0050s
2025-10-16T10:00:12.695912277Z -- create_table(:flipper_gates)
2025-10-16T10:00:12.695920403Z    -> 0.0003s
2025-10-16T10:00:12.695928740Z -- 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-16T10:00:12.695958279Z    -> 0.0001s
2025-10-16T10:00:12.695967167Z == 20240306095646 CreateFlipperTables: migrated (0.0084s) =====================
2025-10-16T10:00:12.695977618Z 
2025-10-16T10:00:12.695985534Z Migrating to RolifyCreateRoles (20240319155251)
2025-10-16T10:00:12.695994502Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-10-16T10:00:12.696002659Z -- create_table(:roles)
2025-10-16T10:00:12.696010514Z    -> 0.0438s
2025-10-16T10:00:12.696018440Z -- create_table(:users_roles, {id: false})
2025-10-16T10:00:12.696026396Z    -> 0.0005s
2025-10-16T10:00:12.696034372Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-10-16T10:00:12.696042549Z    -> 0.0056s
2025-10-16T10:00:12.696050495Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-10-16T10:00:12.696058932Z    -> 0.0002s
2025-10-16T10:00:12.696066838Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-10-16T10:00:12.696075114Z    -> 0.0001s
2025-10-16T10:00:12.696083091Z == 20240319155251 RolifyCreateRoles: migrated (0.0689s) =======================
2025-10-16T10:00:12.696091097Z 
2025-10-16T10:00:12.696099023Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-10-16T10:00:12.696107179Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-10-16T10:00:12.696115426Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0064s) ==================
2025-10-16T10:00:12.696123662Z 
2025-10-16T10:00:12.696131548Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-10-16T10:00:12.696139534Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-10-16T10:00:12.696148432Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-16T10:00:12.696156979Z    -> 0.0495s
2025-10-16T10:00:12.696164895Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0508s) ====================
2025-10-16T10:00:12.696173212Z 
2025-10-16T10:00:12.696180958Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-10-16T10:00:12.696188964Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-10-16T10:00:12.696197040Z -- add_column(:users, :reset_password_token, :string)
2025-10-16T10:00:12.696205146Z    -> 0.0012s
2025-10-16T10:00:12.696214645Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-10-16T10:00:12.696223253Z    -> 0.0002s
2025-10-16T10:00:12.696231139Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0033s) ============
2025-10-16T10:00:12.696250047Z 
2025-10-16T10:00:12.696258393Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-10-16T10:00:12.696266680Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-10-16T10:00:12.696275007Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0259s) ==============
2025-10-16T10:00:12.696283103Z 
2025-10-16T10:00:12.696291650Z Migrating to AddRememberableToUsers (20240410221112)
2025-10-16T10:00:12.696299907Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-10-16T10:00:12.696308304Z -- add_column(:users, :remember_created_at, :datetime)
2025-10-16T10:00:12.696316470Z    -> 0.0036s
2025-10-16T10:00:12.696324316Z == 20240410221112 AddRememberableToUsers: migrated (0.0050s) ==================
2025-10-16T10:00:12.696332352Z 
2025-10-16T10:00:12.696340048Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-10-16T10:00:12.696347964Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-10-16T10:00:12.696355950Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-10-16T10:00:12.696363906Z    -> 0.0015s
2025-10-16T10:00:12.696371952Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0028s) ===========
2025-10-16T10:00:12.696380650Z 
2025-10-16T10:00:12.696388916Z Migrating to DropDelayedJobs (20240418112821)
2025-10-16T10:00:12.696397594Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-10-16T10:00:12.696405730Z -- drop_table(:delayed_jobs)
2025-10-16T10:00:12.696413736Z    -> 0.0018s
2025-10-16T10:00:12.696421782Z == 20240418112821 DropDelayedJobs: migrated (0.0124s) =========================
2025-10-16T10:00:12.696430400Z 
2025-10-16T10:00:12.696438336Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-10-16T10:00:12.696446442Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-10-16T10:00:12.696454589Z -- add_column(:users, :interface_language, :string)
2025-10-16T10:00:12.696462635Z    -> 0.0007s
2025-10-16T10:00:12.696470871Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0043s) =============
2025-10-16T10:00:12.696479198Z 
2025-10-16T10:00:12.696487114Z Migrating to AddLockableToUsers (20240610120318)
2025-10-16T10:00:12.696495250Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-10-16T10:00:12.696503357Z -- change_table(:users)
2025-10-16T10:00:12.696511523Z    -> 0.0019s
2025-10-16T10:00:12.696519339Z == 20240610120318 AddLockableToUsers: migrated (0.0023s) ======================
2025-10-16T10:00:12.696527305Z 
2025-10-16T10:00:12.696544319Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-10-16T10:00:12.696552456Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-10-16T10:00:12.696561023Z -- add_column(:model_files, :attachment_data, :json)
2025-10-16T10:00:12.696569851Z    -> 0.0007s
2025-10-16T10:00:12.696578428Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0011s) ===========
2025-10-16T10:00:12.696587075Z 
2025-10-16T10:00:12.696595893Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-10-16T10:00:12.696604420Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-10-16T10:00:12.696613108Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0221s) ==================
2025-10-16T10:00:12.696621424Z 
2025-10-16T10:00:12.696629400Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-10-16T10:00:12.696637637Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-10-16T10:00:12.696646144Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-10-16T10:00:12.696654832Z    -> 0.0007s
2025-10-16T10:00:12.696662708Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0027s) ============
2025-10-16T10:00:12.696670824Z 
2025-10-16T10:00:12.696678519Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-10-16T10:00:12.696686666Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-10-16T10:00:12.696694972Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-10-16T10:00:12.696703099Z    -> 0.0007s
2025-10-16T10:00:12.696711406Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-10-16T10:00:12.696719582Z    -> 0.0006s
2025-10-16T10:00:12.696727598Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-10-16T10:00:12.696735534Z    -> 0.0006s
2025-10-16T10:00:12.696743450Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-10-16T10:00:12.696751516Z    -> 0.0052s
2025-10-16T10:00:12.696759392Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-10-16T10:00:12.696767358Z    -> 0.0006s
2025-10-16T10:00:12.696775895Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0091s) ====================
2025-10-16T10:00:12.696784382Z 
2025-10-16T10:00:12.696792078Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-10-16T10:00:12.696800004Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-10-16T10:00:12.696808521Z -- remove_index(:libraries, :path)
2025-10-16T10:00:12.696816407Z    -> 0.0019s
2025-10-16T10:00:12.696825746Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0027s) ================
2025-10-16T10:00:12.696843832Z 
2025-10-16T10:00:12.696851648Z Migrating to CreateFederailsActors (20240727113215)
2025-10-16T10:00:12.696859594Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-10-16T10:00:12.696867620Z -- create_table(:federails_actors)
2025-10-16T10:00:12.696875496Z    -> 0.0011s
2025-10-16T10:00:12.696883332Z -- foreign_key_exists?(:federails_actors, :users)
2025-10-16T10:00:12.696891248Z    -> 0.0018s
2025-10-16T10:00:12.696899103Z -- remove_foreign_key(:federails_actors, :users)
2025-10-16T10:00:12.696907029Z    -> 0.0125s
2025-10-16T10:00:12.696915076Z -- remove_index(:federails_actors, :user_id)
2025-10-16T10:00:12.696923282Z    -> 0.0004s
2025-10-16T10:00:12.696931338Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-10-16T10:00:12.696939765Z    -> 0.0001s
2025-10-16T10:00:12.696947802Z -- add_foreign_key(:federails_actors, :users)
2025-10-16T10:00:12.696955818Z    -> 0.0106s
2025-10-16T10:00:12.696963924Z == 20240727113215 CreateFederailsActors: migrated (0.0275s) ===================
2025-10-16T10:00:12.696972141Z 
2025-10-16T10:00:12.696980477Z Migrating to CreateFederailsFollowings (20240727113216)
2025-10-16T10:00:12.696988954Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-10-16T10:00:12.696997021Z -- create_table(:federails_followings)
2025-10-16T10:00:12.697005037Z    -> 0.0012s
2025-10-16T10:00:12.697015217Z == 20240727113216 CreateFederailsFollowings: migrated (0.0012s) ===============
2025-10-16T10:00:12.697026941Z 
2025-10-16T10:00:12.697036650Z Migrating to CreateFederailsActivities (20240727113217)
2025-10-16T10:00:12.697044777Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-10-16T10:00:12.697052993Z -- create_table(:federails_activities)
2025-10-16T10:00:12.697061400Z    -> 0.0091s
2025-10-16T10:00:12.697069487Z == 20240727113217 CreateFederailsActivities: migrated (0.0091s) ===============
2025-10-16T10:00:12.697077613Z 
2025-10-16T10:00:12.697085288Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-10-16T10:00:12.697093184Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-10-16T10:00:12.697101110Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-10-16T10:00:12.697109417Z    -> 0.0084s
2025-10-16T10:00:12.697117293Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-10-16T10:00:12.697125439Z    -> 0.0004s
2025-10-16T10:00:12.697142453Z -- change_table(:federails_actors)
2025-10-16T10:00:12.697150880Z    -> 0.0068s
2025-10-16T10:00:12.697158766Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0157s) =======
2025-10-16T10:00:12.697167223Z 
2025-10-16T10:00:12.697177845Z Migrating to CreateFederailsActors (20240731165647)
2025-10-16T10:00:12.697188787Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-10-16T10:00:12.697199428Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-10-16T10:00:12.697210621Z 
2025-10-16T10:00:12.697220781Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-10-16T10:00:12.697231603Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-10-16T10:00:12.697239789Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-10-16T10:00:12.697247986Z 
2025-10-16T10:00:12.697255832Z Migrating to BackfillActivities (20240805111500)
2025-10-16T10:00:12.697263928Z == 20240805111500 BackfillActivities: migrating ===============================
2025-10-16T10:00:12.697272114Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-10-16T10:00:12.697280361Z 
2025-10-16T10:00:12.697288047Z Migrating to CreateCaberRelations (20240827155630)
2025-10-16T10:00:12.697296443Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-10-16T10:00:12.697304550Z -- create_table(:caber_relations)
2025-10-16T10:00:12.697313047Z    -> 0.0398s
2025-10-16T10:00:12.697321504Z == 20240827155630 CreateCaberRelations: migrated (0.0398s) ====================
2025-10-16T10:00:12.697329690Z 
2025-10-16T10:00:12.697337546Z Migrating to AddDefaultAccessControls (20240830121749)
2025-10-16T10:00:12.697345653Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-10-16T10:00:13.423277614Z == 20240830121749 AddDefaultAccessControls: migrated (0.0608s) ================
2025-10-16T10:00:13.423312043Z 
2025-10-16T10:00:13.423321622Z Migrating to RenameDefaultRoles (20240830151650)
2025-10-16T10:00:13.423330310Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-10-16T10:00:13.423339078Z == 20240830151650 RenameDefaultRoles: migrated (0.0466s) ======================
2025-10-16T10:00:13.423347475Z 
2025-10-16T10:00:13.423355781Z Migrating to AddPublicIDsToModels (20240904151944)
2025-10-16T10:00:13.423364178Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-10-16T10:00:13.423372745Z -- add_column(:models, :public_id, :string)
2025-10-16T10:00:13.423380912Z    -> 0.0010s
2025-10-16T10:00:13.423389339Z -- add_index(:models, :public_id)
2025-10-16T10:00:13.423420201Z    -> 0.0027s
2025-10-16T10:00:13.423428538Z -- add_column(:model_files, :public_id, :string)
2025-10-16T10:00:13.423436814Z    -> 0.0007s
2025-10-16T10:00:13.423445171Z -- add_index(:model_files, :public_id)
2025-10-16T10:00:13.423453518Z    -> 0.0002s
2025-10-16T10:00:13.423461624Z -- add_column(:problems, :public_id, :string)
2025-10-16T10:00:13.423469751Z    -> 0.0007s
2025-10-16T10:00:13.423477827Z -- add_index(:problems, :public_id)
2025-10-16T10:00:13.423485873Z    -> 0.0002s
2025-10-16T10:00:13.423493889Z -- add_column(:creators, :public_id, :string)
2025-10-16T10:00:13.423502016Z    -> 0.0007s
2025-10-16T10:00:13.423510322Z -- add_index(:creators, :public_id)
2025-10-16T10:00:13.423518349Z    -> 0.0002s
2025-10-16T10:00:13.423526946Z -- add_column(:collections, :public_id, :string)
2025-10-16T10:00:13.423535303Z    -> 0.0007s
2025-10-16T10:00:13.423543349Z -- add_index(:collections, :public_id)
2025-10-16T10:00:13.423551826Z    -> 0.0002s
2025-10-16T10:00:13.423559842Z -- add_column(:libraries, :public_id, :string)
2025-10-16T10:00:13.423567968Z    -> 0.0007s
2025-10-16T10:00:13.423576466Z -- add_index(:libraries, :public_id)
2025-10-16T10:00:13.423584722Z    -> 0.0002s
2025-10-16T10:00:13.423592808Z == 20240904151944 AddPublicIDsToModels: migrated (0.0082s) ====================
2025-10-16T10:00:13.423601025Z 
2025-10-16T10:00:13.423608961Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-10-16T10:00:13.423617107Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-10-16T10:00:13.423625334Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:13.423633771Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0611s) ==============
2025-10-16T10:00:13.423642228Z 
2025-10-16T10:00:13.423650615Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-10-16T10:00:13.423659292Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-10-16T10:00:13.423668090Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-10-16T10:00:13.423676397Z 
2025-10-16T10:00:13.423684333Z Migrating to DeduplicateRoles (20240923114515)
2025-10-16T10:00:13.423692389Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-10-16T10:00:13.423700585Z == 20240923114515 DeduplicateRoles: migrated (0.1619s) ========================
2025-10-16T10:00:13.423708862Z 
2025-10-16T10:00:13.423716748Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-10-16T10:00:13.423752259Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-10-16T10:00:13.423761989Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-16T10:00:13.423771007Z    -> 0.1028s
2025-10-16T10:00:13.423779194Z -- add_index(:models, :name_lower)
2025-10-16T10:00:13.423787460Z    -> 0.0002s
2025-10-16T10:00:13.423795587Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-16T10:00:13.423804284Z    -> 0.0711s
2025-10-16T10:00:13.423812370Z -- add_index(:creators, :name_lower)
2025-10-16T10:00:13.423820697Z    -> 0.0002s
2025-10-16T10:00:13.423828753Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-16T10:00:13.423837371Z    -> 0.0090s
2025-10-16T10:00:13.423860046Z -- add_index(:collections, :name_lower)
2025-10-16T10:00:13.423870988Z    -> 0.0002s
2025-10-16T10:00:13.423879125Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1836s) =============
2025-10-16T10:00:13.423887672Z 
2025-10-16T10:00:13.423895849Z Migrating to AddKeypairToActors (20240926162407)
2025-10-16T10:00:13.423903965Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-10-16T10:00:13.423912312Z -- change_table(:federails_actors)
2025-10-16T10:00:13.423920348Z    -> 0.0016s
2025-10-16T10:00:13.423928374Z == 20240926162407 AddKeypairToActors: migrated (0.0017s) ======================
2025-10-16T10:00:13.423936550Z 
2025-10-16T10:00:13.423944707Z Migrating to AddUuids (20241004194445)
2025-10-16T10:00:13.423952813Z == 20241004194445 AddUuids: migrating =========================================
2025-10-16T10:00:13.423961010Z -- change_table(:federails_actors)
2025-10-16T10:00:13.423969106Z    -> 0.0031s
2025-10-16T10:00:13.423977353Z -- change_table(:federails_activities)
2025-10-16T10:00:13.423985429Z    -> 0.0009s
2025-10-16T10:00:13.423993635Z -- change_table(:federails_followings)
2025-10-16T10:00:13.424001902Z    -> 0.0009s
2025-10-16T10:00:13.424010068Z == 20241004194445 AddUuids: migrated (0.0049s) ================================
2025-10-16T10:00:13.424019367Z 
2025-10-16T10:00:13.424027353Z Migrating to CreateComments (20241007182824)
2025-10-16T10:00:13.424035420Z == 20241007182824 CreateComments: migrating ===================================
2025-10-16T10:00:13.424043646Z -- create_table(:comments)
2025-10-16T10:00:13.424051582Z    -> 0.0021s
2025-10-16T10:00:13.424059578Z == 20241007182824 CreateComments: migrated (0.0021s) ==========================
2025-10-16T10:00:13.424077364Z 
2025-10-16T10:00:13.424085300Z Migrating to AddSystemToComments (20241009122540)
2025-10-16T10:00:13.424093697Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-10-16T10:00:13.424101984Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-10-16T10:00:13.424110270Z    -> 0.0009s
2025-10-16T10:00:13.424118427Z == 20241009122540 AddSystemToComments: migrated (0.0010s) =====================
2025-10-16T10:00:13.424126904Z 
2025-10-16T10:00:13.424135070Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-10-16T10:00:13.424143317Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-10-16T10:00:13.424151523Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0016s) ============
2025-10-16T10:00:13.424159910Z 
2025-10-16T10:00:13.424168147Z Migrating to AddOmniauthToUsers (20241015090803)
2025-10-16T10:00:13.424176514Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-10-16T10:00:13.424184750Z -- add_column(:users, :auth_provider, :string)
2025-10-16T10:00:13.424193428Z    -> 0.0009s
2025-10-16T10:00:13.424202165Z -- add_column(:users, :auth_uid, :string)
2025-10-16T10:00:13.424210392Z    -> 0.0008s
2025-10-16T10:00:13.424218418Z == 20241015090803 AddOmniauthToUsers: migrated (0.0017s) ======================
2025-10-16T10:00:13.424227055Z 
2025-10-16T10:00:13.424235102Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-10-16T10:00:13.424243238Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-10-16T10:00:13.424251374Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-10-16T10:00:13.424259571Z    -> 0.0015s
2025-10-16T10:00:13.424268078Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-10-16T10:00:13.424276425Z    -> 0.0010s
2025-10-16T10:00:13.424284411Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0026s) =====
2025-10-16T10:00:13.424292808Z 
2025-10-16T10:00:13.424300864Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-10-16T10:00:13.424309111Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-10-16T10:00:13.424317648Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-10-16T10:00:13.424326055Z    -> 0.0009s
2025-10-16T10:00:13.424334131Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0010s) ======
2025-10-16T10:00:13.424342718Z 
2025-10-16T10:00:13.424350694Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-10-16T10:00:13.424359191Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-10-16T10:00:13.424377067Z -- change_table(:users)
2025-10-16T10:00:13.424385164Z    -> 0.0011s
2025-10-16T10:00:13.424393140Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0012s) =====================
2025-10-16T10:00:13.424401326Z 
2025-10-16T10:00:13.424409743Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-10-16T10:00:13.424417819Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-10-16T10:00:13.424425956Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0090s) =================
2025-10-16T10:00:13.424434232Z 
2025-10-16T10:00:13.424442078Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-10-16T10:00:13.424450124Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-10-16T10:00:13.424458411Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-10-16T10:00:13.424467039Z    -> 0.0009s
2025-10-16T10:00:13.424475445Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-10-16T10:00:13.424484123Z    -> 0.0012s
2025-10-16T10:00:13.424492219Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-10-16T10:00:13.424500586Z    -> 0.0004s
2025-10-16T10:00:13.424508562Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-10-16T10:00:13.424517129Z    -> 0.0009s
2025-10-16T10:00:13.424525115Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-10-16T10:00:13.424533492Z    -> 0.0009s
2025-10-16T10:00:13.424542220Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-10-16T10:00:13.424550677Z    -> 0.0008s
2025-10-16T10:00:13.424558703Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-10-16T10:00:13.424567190Z    -> 0.0005s
2025-10-16T10:00:13.424575216Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0058s) ===================
2025-10-16T10:00:13.424583463Z 
2025-10-16T10:00:13.424591379Z Migrating to AddInProgressToProblems (20241105121830)
2025-10-16T10:00:13.424599515Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-10-16T10:00:13.424607692Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-10-16T10:00:13.424615898Z    -> 0.0010s
2025-10-16T10:00:13.424623894Z == 20241105121830 AddInProgressToProblems: migrated (0.0010s) =================
2025-10-16T10:00:13.424632712Z 
2025-10-16T10:00:13.424640618Z Migrating to ClearStuckProblems (20241118155027)
2025-10-16T10:00:13.424804728Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-10-16T10:00:13.424814318Z == 20241118155027 ClearStuckProblems: migrated (0.0181s) ======================
2025-10-16T10:00:13.424822965Z 
2025-10-16T10:00:13.424831041Z Migrating to AddApprovedToUser (20241122121621)
2025-10-16T10:00:13.424839338Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-10-16T10:00:13.424847805Z -- change_table(:users)
2025-10-16T10:00:13.424856132Z    -> 0.0016s
2025-10-16T10:00:13.424864429Z == 20241122121621 AddApprovedToUser: migrated (0.0016s) =======================
2025-10-16T10:00:13.424872906Z 
2025-10-16T10:00:13.424880902Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-10-16T10:00:13.424889088Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-10-16T10:00:13.424897305Z -- create_table(:federails_moderation_reports)
2025-10-16T10:00:13.424905401Z    -> 0.0032s
2025-10-16T10:00:13.424913507Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0033s) ========
2025-10-16T10:00:13.424921894Z 
2025-10-16T10:00:13.424930171Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-10-16T10:00:13.424938568Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-10-16T10:00:13.424946845Z -- create_table(:federails_moderation_domain_blocks)
2025-10-16T10:00:13.424955011Z    -> 0.0006s
2025-10-16T10:00:13.424963037Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0007s) ===
2025-10-16T10:00:13.424971254Z 
2025-10-16T10:00:13.424979079Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-10-16T10:00:13.424987306Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-10-16T10:00:13.424995563Z -- change_column_null(:comments, :commenter_id, true)
2025-10-16T10:00:13.425003699Z    -> 0.0096s
2025-10-16T10:00:13.425013348Z -- change_column_null(:comments, :commenter_type, true)
2025-10-16T10:00:13.425021475Z    -> 0.0083s
2025-10-16T10:00:13.425029501Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-10-16T10:00:13.425037778Z    -> 0.0009s
2025-10-16T10:00:13.425046024Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-10-16T10:00:13.425054682Z    -> 0.0118s
2025-10-16T10:00:14.183072221Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0324s) =======
2025-10-16T10:00:14.183097913Z 
2025-10-16T10:00:14.183102642Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-10-16T10:00:14.183106420Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-10-16T10:00:14.183123605Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-10-16T10:00:14.183127693Z    -> 0.0017s
2025-10-16T10:00:14.183131951Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0017s) =================
2025-10-16T10:00:14.183135689Z 
2025-10-16T10:00:14.183139206Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-10-16T10:00:14.183142924Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-10-16T10:00:14.183146671Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1288s) ==================
2025-10-16T10:00:14.183150809Z 
2025-10-16T10:00:14.183154848Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-10-16T10:00:14.183158455Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-10-16T10:00:14.183162894Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-10-16T10:00:14.183166531Z    -> 0.0019s
2025-10-16T10:00:14.183170800Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0019s) ==========
2025-10-16T10:00:14.183174888Z 
2025-10-16T10:00:14.183178686Z Migrating to AddCreatorToCollections (20250222000000)
2025-10-16T10:00:14.183182543Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-10-16T10:00:14.183186611Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-10-16T10:00:14.183190559Z    -> 0.0245s
2025-10-16T10:00:14.183194878Z == 20250222000000 AddCreatorToCollections: migrated (0.0246s) =================
2025-10-16T10:00:14.183199026Z 
2025-10-16T10:00:14.183202794Z Migrating to AddLocalToActors (20250305171530)
2025-10-16T10:00:14.183206642Z == 20250305171530 AddLocalToActors: migrating =================================
2025-10-16T10:00:14.183210540Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-10-16T10:00:14.183215119Z    -> 0.0010s
2025-10-16T10:00:14.183218846Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-10-16T10:00:14.183222915Z    -> 0.0018s
2025-10-16T10:00:14.183226512Z    -> 0 rows
2025-10-16T10:00:14.183230249Z == 20250305171530 AddLocalToActors: migrated (0.0057s) ========================
2025-10-16T10:00:14.183234137Z 
2025-10-16T10:00:14.183237875Z Migrating to AddActorTypeToActors (20250407160721)
2025-10-16T10:00:14.183241622Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-10-16T10:00:14.183245450Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-10-16T10:00:14.183249077Z    -> 0.0008s
2025-10-16T10:00:14.183252614Z == 20250407160721 AddActorTypeToActors: migrated (0.0008s) ====================
2025-10-16T10:00:14.183261111Z 
2025-10-16T10:00:14.183264619Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-10-16T10:00:14.183268927Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-10-16T10:00:14.183272565Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-10-16T10:00:14.183276553Z    -> 0.0013s
2025-10-16T10:00:14.183280270Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0013s) =================
2025-10-16T10:00:14.183283867Z 
2025-10-16T10:00:14.183287344Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-10-16T10:00:14.183291322Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-10-16T10:00:14.183294899Z -- create_table(:oauth_applications)
2025-10-16T10:00:14.183298517Z    -> 0.0004s
2025-10-16T10:00:14.183302044Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-10-16T10:00:14.183305872Z    -> 0.0002s
2025-10-16T10:00:14.183309840Z -- create_table(:oauth_access_grants)
2025-10-16T10:00:14.183313457Z    -> 0.0009s
2025-10-16T10:00:14.183317004Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-10-16T10:00:14.183320611Z    -> 0.0001s
2025-10-16T10:00:14.183324168Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-10-16T10:00:14.183327806Z    -> 0.0072s
2025-10-16T10:00:14.183331343Z -- create_table(:oauth_access_tokens)
2025-10-16T10:00:14.183334880Z    -> 0.0006s
2025-10-16T10:00:14.183338417Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-10-16T10:00:14.183342205Z    -> 0.0001s
2025-10-16T10:00:14.183345752Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-10-16T10:00:14.183349359Z    -> 0.0001s
2025-10-16T10:00:14.183352896Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-10-16T10:00:14.183356534Z    -> 0.0089s
2025-10-16T10:00:14.183360061Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-10-16T10:00:14.183363638Z    -> 0.0098s
2025-10-16T10:00:14.183367155Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-10-16T10:00:14.183371043Z    -> 0.0090s
2025-10-16T10:00:14.183374570Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0376s) ==================
2025-10-16T10:00:14.183378197Z 
2025-10-16T10:00:14.183381654Z Migrating to AddOwnerToApplication (20250408145956)
2025-10-16T10:00:14.183385542Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-10-16T10:00:14.183394270Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-10-16T10:00:14.183398368Z    -> 0.0009s
2025-10-16T10:00:14.183402015Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-10-16T10:00:14.183405642Z    -> 0.0008s
2025-10-16T10:00:14.183409981Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-10-16T10:00:14.183413679Z    -> 0.0002s
2025-10-16T10:00:14.183417356Z == 20250408145956 AddOwnerToApplication: migrated (0.0067s) ===================
2025-10-16T10:00:14.183421374Z 
2025-10-16T10:00:14.183425192Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-10-16T10:00:14.183429080Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-10-16T10:00:14.183432677Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-10-16T10:00:14.183436565Z    -> 0.0099s
2025-10-16T10:00:14.183440072Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0113s) ============
2025-10-16T10:00:14.183444020Z 
2025-10-16T10:00:14.183447787Z Migrating to AddQuotaToUsers (20250409125753)
2025-10-16T10:00:14.183451425Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-10-16T10:00:14.183455172Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-10-16T10:00:14.183458930Z    -> 0.0010s
2025-10-16T10:00:14.183462677Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-10-16T10:00:14.183466715Z    -> 0.0011s
2025-10-16T10:00:14.183470543Z == 20250409125753 AddQuotaToUsers: migrated (0.0034s) =========================
2025-10-16T10:00:14.183474150Z 
2025-10-16T10:00:14.183477597Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-10-16T10:00:14.183481205Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-10-16T10:00:14.183485303Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-10-16T10:00:14.183489702Z    -> 0.0115s
2025-10-16T10:00:14.183493650Z -- add_index(:model_files, :filename_lower)
2025-10-16T10:00:14.183497457Z    -> 0.0002s
2025-10-16T10:00:14.183500974Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0130s) 
2025-10-16T10:00:14.183504882Z 
2025-10-16T10:00:14.183508329Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-10-16T10:00:14.183511956Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-10-16T10:00:14.183515834Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-10-16T10:00:14.183519401Z    -> 0.0002s
2025-10-16T10:00:14.183575915Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-10-16T10:00:14.183579573Z 
2025-10-16T10:00:14.183583040Z Migrating to AddPreviewToModelFile (20250520111046)
2025-10-16T10:00:14.183586887Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-10-16T10:00:14.183590465Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-10-16T10:00:14.183594062Z    -> 0.0010s
2025-10-16T10:00:14.183597569Z == 20250520111046 AddPreviewToModelFile: migrated (0.0018s) ===================
2025-10-16T10:00:14.183601136Z 
2025-10-16T10:00:14.183604583Z Migrating to CreateAltchaSolutions (20250609210440)
2025-10-16T10:00:14.183608120Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-10-16T10:00:14.183611968Z -- create_table(:altcha_solutions)
2025-10-16T10:00:14.183615595Z    -> 0.0004s
2025-10-16T10:00:14.183619363Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-10-16T10:00:14.183623391Z    -> 0.0002s
2025-10-16T10:00:14.183627148Z == 20250609210440 CreateAltchaSolutions: migrated (0.0016s) ===================
2025-10-16T10:00:14.183631046Z 
2025-10-16T10:00:14.183634734Z Migrating to AddIndexableFields (20250620141805)
2025-10-16T10:00:14.183638281Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-10-16T10:00:14.183642099Z -- change_table(:models)
2025-10-16T10:00:14.183646297Z    -> 0.0024s
2025-10-16T10:00:14.183650045Z -- change_table(:creators)
2025-10-16T10:00:14.183653552Z    -> 0.0017s
2025-10-16T10:00:14.183657069Z -- change_table(:collections)
2025-10-16T10:00:14.183660586Z    -> 0.0017s
2025-10-16T10:00:14.183664484Z == 20250620141805 AddIndexableFields: migrated (0.0059s) ======================
2025-10-16T10:00:14.183668091Z 
2025-10-16T10:00:14.183671558Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-10-16T10:00:14.183675566Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-10-16T10:00:14.183679163Z -- change_column(:models, :indexable, :string)
2025-10-16T10:00:14.183682831Z    -> 0.0346s
2025-10-16T10:00:14.183686348Z -- change_column(:models, :ai_indexable, :string)
2025-10-16T10:00:14.183689915Z    -> 0.0203s
2025-10-16T10:00:14.183693422Z -- change_column(:creators, :indexable, :string)
2025-10-16T10:00:14.183696979Z    -> 0.0104s
2025-10-16T10:00:14.183700727Z -- change_column(:creators, :ai_indexable, :string)
2025-10-16T10:00:14.183704544Z    -> 0.0101s
2025-10-16T10:00:14.183712621Z -- change_column(:collections, :indexable, :string)
2025-10-16T10:00:14.183716208Z    -> 0.0471s
2025-10-16T10:00:14.183720146Z -- change_column(:collections, :ai_indexable, :string)
2025-10-16T10:00:14.183724144Z    -> 0.0195s
2025-10-16T10:00:14.183727691Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1425s) ======
2025-10-16T10:00:14.183731308Z 
2025-10-16T10:00:14.183735006Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-10-16T10:00:14.183739194Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-10-16T10:00:14.183743292Z -- change_table(:models)
2025-10-16T10:00:14.183746900Z    -> 0.0004s
2025-10-16T10:00:14.183750847Z -- change_table(:creators)
2025-10-16T10:00:14.183754595Z    -> 0.0003s
2025-10-16T10:00:14.183758343Z -- change_table(:collections)
2025-10-16T10:00:14.183761860Z    -> 0.0003s
2025-10-16T10:00:14.183765617Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0009s) =================
2025-10-16T10:00:14.183769575Z 
2025-10-16T10:00:14.183773343Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-10-16T10:00:14.183776930Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-10-16T10:00:14.183780527Z -- change_table(:links)
2025-10-16T10:00:14.183784054Z    -> 0.0002s
2025-10-16T10:00:14.183787591Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-10-16T10:00:14.183791239Z 
2025-10-16T10:00:14.183794716Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-10-16T10:00:14.183798313Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-10-16T10:00:14.183801920Z -- add_column(:links, :synced_at, :datetime)
2025-10-16T10:00:14.183805477Z    -> 0.0018s
2025-10-16T10:00:14.183809005Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0018s) ======================
2025-10-16T10:00:14.183812592Z 
2025-10-16T10:00:14.183816059Z Migrating to CreateFaspClientProviders (20250806142734)
2025-10-16T10:00:14.183819646Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-10-16T10:00:14.183823263Z -- create_table(:fasp_client_providers)
2025-10-16T10:00:14.183827071Z    -> 0.0430s
2025-10-16T10:00:14.183830598Z == 20250806142734 CreateFaspClientProviders: migrated (0.0431s) ===============
2025-10-16T10:00:14.183834205Z 
2025-10-16T10:00:14.183837652Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-10-16T10:00:14.183841229Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-10-16T10:00:14.183853765Z -- create_table(:fasp_client_event_subscriptions)
2025-10-16T10:00:14.183863174Z    -> 0.0128s
2025-10-16T10:00:14.243932841Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0128s) ======
2025-10-16T10:00:14.243958643Z 
2025-10-16T10:00:14.243967882Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-10-16T10:00:14.243976479Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-10-16T10:00:14.243985106Z -- create_table(:fasp_client_backfill_requests)
2025-10-16T10:00:14.243993193Z    -> 0.0051s
2025-10-16T10:00:14.244001860Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0051s) ========
2025-10-16T10:00:14.244010127Z 
2025-10-16T10:00:14.244018443Z Migrating to AddImagesToCreators (20250922155445)
2025-10-16T10:00:14.244026500Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-10-16T10:00:14.244034626Z -- add_column(:creators, :avatar_data, :json)
2025-10-16T10:00:14.244042632Z    -> 0.0011s
2025-10-16T10:00:14.244050448Z -- add_column(:creators, :banner_data, :json)
2025-10-16T10:00:14.244059015Z    -> 0.0009s
2025-10-16T10:00:14.244066781Z == 20250922155445 AddImagesToCreators: migrated (0.0020s) =====================
2025-10-16T10:00:14.244074907Z 
2025-10-16T10:00:14.244083034Z Migrating to CreateFederailsHosts (20251010145758)
2025-10-16T10:00:14.244090919Z == 20251010145758 CreateFederailsHosts: migrating =============================
2025-10-16T10:00:14.244098875Z -- create_table(:federails_hosts)
2025-10-16T10:00:14.244106741Z    -> 0.0186s
2025-10-16T10:00:14.244114667Z == 20251010145758 CreateFederailsHosts: migrated (0.0187s) ====================
2025-10-16T10:00:14.244122824Z 
2025-10-16T10:00:14.336079840Z s6-rc: info: service init-manyfold-config successfully started
2025-10-16T10:00:14.336345014Z s6-rc: info: service init-config-end: starting
2025-10-16T10:00:14.338557217Z s6-rc: info: service init-config-end successfully started
2025-10-16T10:00:14.338749294Z s6-rc: info: service init-mods: starting
2025-10-16T10:00:14.340545230Z s6-rc: info: service init-mods successfully started
2025-10-16T10:00:14.340859803Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-10-16T10:00:14.349465930Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-10-16T10:00:14.349721214Z s6-rc: info: service init-mods-package-install: starting
2025-10-16T10:00:14.361235085Z [pkg-install-init] **** Installing all mod packages ****
2025-10-16T10:00:14.372034717Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-10-16T10:00:14.458477201Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-10-16T10:00:14.792238430Z (1/1) Installing redis (8.0.4-r0)
2025-10-16T10:00:14.805263683Z Executing redis-8.0.4-r0.pre-install
2025-10-16T10:00:14.858509582Z Executing redis-8.0.4-r0.post-install
2025-10-16T10:00:14.866528878Z Executing busybox-1.37.0-r19.trigger
2025-10-16T10:00:14.882200229Z OK: 428 MiB in 119 packages
2025-10-16T10:00:14.979073963Z s6-rc: info: service init-mods-package-install successfully started
2025-10-16T10:00:14.979278224Z s6-rc: info: service init-mods-end: starting
2025-10-16T10:00:14.981376920Z s6-rc: info: service init-mods-end successfully started
2025-10-16T10:00:14.981557403Z s6-rc: info: service init-custom-files: starting
2025-10-16T10:00:14.988847290Z [custom-init] No custom files found, skipping...
2025-10-16T10:00:14.989607771Z s6-rc: info: service init-custom-files successfully started
2025-10-16T10:00:14.989863105Z s6-rc: info: service init-services: starting
2025-10-16T10:00:14.991349097Z s6-rc: info: service init-services successfully started
2025-10-16T10:00:14.991611425Z s6-rc: info: service svc-mod-universal-redis: starting
2025-10-16T10:00:14.991830195Z s6-rc: info: service svc-manyfold: starting
2025-10-16T10:00:14.992133336Z s6-rc: info: service svc-cron: starting
2025-10-16T10:00:14.994933924Z s6-rc: info: service svc-cron successfully started
2025-10-16T10:00:14.995184659Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-10-16T10:00:15.005363341Z 279:C 16 Oct 2025 10:00:15.005 # 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-16T10:00:15.005422110Z 279:C 16 Oct 2025 10:00:15.005 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-10-16T10:00:15.005459555Z 279:C 16 Oct 2025 10:00:15.005 * Redis version=8.0.4, bits=64, commit=00000000, modified=1, pid=279, just started
2025-10-16T10:00:15.005469575Z 279:C 16 Oct 2025 10:00:15.005 # 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-16T10:00:15.006053150Z 279:M 16 Oct 2025 10:00:15.006 * monotonic clock: POSIX clock_gettime
2025-10-16T10:00:15.006545732Z 279:M 16 Oct 2025 10:00:15.006 * Running mode=standalone, port=6379.
2025-10-16T10:00:15.006847229Z 279:M 16 Oct 2025 10:00:15.006 * Server initialized
2025-10-16T10:00:15.006875416Z 279:M 16 Oct 2025 10:00:15.006 * Ready to accept connections tcp
2025-10-16T10:00:15.165029576Z 10:00:15 rails.1              | started with pid 301
2025-10-16T10:00:15.165071521Z 10:00:15 default_worker.1     | started with pid 302
2025-10-16T10:00:15.165102934Z 10:00:15 performance_worker.1 | started with pid 303
2025-10-16T10:00:16.464961297Z 10:00:16 rails.1              | `/root` is not writable.
2025-10-16T10:00:16.465027751Z 10:00:16 rails.1              | Bundler will use `/tmp/bundler20251016-301-e0q1t301' as your home directory temporarily.
2025-10-16T10:00:16.933016108Z 10:00:16 performance_worker.1 | `/root` is not writable.
2025-10-16T10:00:16.933041849Z 10:00:16 performance_worker.1 | Bundler will use `/tmp/bundler20251016-303-gxcgbx303' as your home directory temporarily.
2025-10-16T10:00:16.933805767Z 10:00:16 default_worker.1     | `/root` is not writable.
2025-10-16T10:00:16.933848433Z 10:00:16 default_worker.1     | Bundler will use `/tmp/bundler20251016-302-9lfsl8302' as your home directory temporarily.
2025-10-16T10:00:17.888858287Z 10:00:17 rails.1              | => Booting Puma
2025-10-16T10:00:17.888901263Z 10:00:17 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-10-16T10:00:17.888911213Z 10:00:17 rails.1              | => Run `bin/rails server --help` for more startup options
2025-10-16T10:00:18.440847803Z 10:00:18 default_worker.1     | Server: bce9365d53e0, Context: rails, Role: web, data: {cpu: {one_min: 6.62, five_min: 3.31, fifteen_min: 2.53}, memory: 0.191496192e9, disk: {available: 828904898560, total: 938656133120, used: 109751234560}}
2025-10-16T10:00:18.448984925Z 10:00:18 performance_worker.1 | Server: bce9365d53e0, Context: rails, Role: web, data: {cpu: {one_min: 6.62, five_min: 3.31, fifteen_min: 2.53}, memory: 0.191496192e9, disk: {available: 828904124416, total: 938656133120, used: 109752008704}}
2025-10-16T10:00:20.668480900Z 10:00:20 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:20.670031392Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.669Z pid=303 tid=247: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-16T10:00:20.675324919Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.674Z pid=303 tid=247: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-16T10:00:20.676253769Z 10:00:20 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:20.676719076Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.676Z pid=303 tid=247: Cron Jobs - added job with name clear-downloads in the namespace default
2025-10-16T10:00:20.677423785Z 10:00:20 default_worker.1     | INFO  2025-10-16T10:00:20.677Z pid=302 tid=246: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-16T10:00:20.730122573Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.729Z pid=303 tid=247: Booted Rails 8.0.2.1 application in production environment
2025-10-16T10:00:20.730156060Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.729Z pid=303 tid=247: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-16T10:00:20.730250300Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.729Z pid=303 tid=247: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-16T10:00:20.730280430Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.729Z pid=303 tid=247: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-16T10:00:20.732894413Z 10:00:20 performance_worker.1 | INFO  2025-10-16T10:00:20.732Z pid=303 tid=247: Sidekiq 8.0.8 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-10-16T10:00:20.742076890Z 10:00:20 default_worker.1     | INFO  2025-10-16T10:00:20.741Z pid=302 tid=246: Booted Rails 8.0.2.1 application in production environment
2025-10-16T10:00:20.742105127Z 10:00:20 default_worker.1     | INFO  2025-10-16T10:00:20.741Z pid=302 tid=246: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-16T10:00:20.742213195Z 10:00:20 default_worker.1     | INFO  2025-10-16T10:00:20.741Z pid=302 tid=246: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-16T10:00:20.742239087Z 10:00:20 default_worker.1     | INFO  2025-10-16T10:00:20.741Z pid=302 tid=246: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-16T10:00:20.744887308Z 10:00:20 default_worker.1     | INFO  2025-10-16T10:00:20.744Z pid=302 tid=246: Sidekiq 8.0.8 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-10-16T10:00:20.850609308Z 10:00:20 rails.1              | Server: bce9365d53e0, Context: rails, Role: web, data: {cpu: {one_min: 6.62, five_min: 3.31, fifteen_min: 2.53}, memory: 0.176685056e9, disk: {available: 828960043008, total: 938656133120, used: 109696090112}}
2025-10-16T10:00:20.850642294Z 10:00:20 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:20.850650952Z 10:00:20 rails.1              | INFO  2025-10-16T10:00:20.670Z pid=301 tid=205: Sidekiq 8.0.8 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-16T10:00:20.850714350Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 147f832b-e0b2-4f1c-83a9-bce97f9bc816) 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-16T10:00:20.850755522Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 4aefeaa1-e179-4044-a523-354bc9d39c5c) 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-16T10:00:20.850805293Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 23c7440f-aff0-47ad-ac97-103ac215e318) 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-16T10:00:20.850851235Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: f8d02960-5f45-4b4f-8248-0323038217e2) to Sidekiq(upgrade)
2025-10-16T10:00:20.850899081Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 954ce8ec-52d8-4b01-86ea-fd03132a1fe5) to Sidekiq(upgrade)
2025-10-16T10:00:20.850966267Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 6512f0dc-cc8f-49b3-9597-1ae773dc7403) to Sidekiq(upgrade)
2025-10-16T10:00:20.857167091Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: b36236be-2ddb-48fc-9823-b0308e7209b9) to Sidekiq(upgrade)
2025-10-16T10:00:20.857300649Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: fdbc7719-c398-489b-969b-9bb15cef8a9a) to Sidekiq(upgrade)
2025-10-16T10:00:20.857345901Z 10:00:20 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d) to Sidekiq(upgrade)
2025-10-16T10:00:20.857400731Z 10:00:20 rails.1              | [301] Puma starting in cluster mode...
2025-10-16T10:00:20.857444800Z 10:00:20 rails.1              | [301] * Puma version: 7.0.4 ("Romantic Warrior")
2025-10-16T10:00:20.857497145Z 10:00:20 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-16T10:00:20.857536745Z 10:00:20 rails.1              | [301] *  Min threads: 4
2025-10-16T10:00:20.857589972Z 10:00:20 rails.1              | [301] *  Max threads: 16
2025-10-16T10:00:20.857628690Z 10:00:20 rails.1              | [301] *  Environment: production
2025-10-16T10:00:20.857682548Z 10:00:20 rails.1              | [301] *   Master PID: 301
2025-10-16T10:00:20.857723280Z 10:00:20 rails.1              | [301] *      Workers: 4
2025-10-16T10:00:20.857779854Z 10:00:20 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-10-16T10:00:20.857823973Z 10:00:20 rails.1              | [301] * Preloading application
2025-10-16T10:00:20.857873663Z 10:00:20 rails.1              | [301] * Listening on http://[::]:3214
2025-10-16T10:00:20.857913864Z 10:00:20 rails.1              | [301] Use Ctrl-C to stop
2025-10-16T10:00:20.882743744Z 10:00:20 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-10-16T10:00:20.882798444Z 10:00:20 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.02s, phase: 0
2025-10-16T10:00:20.882853695Z 10:00:20 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-10-16T10:00:20.884296660Z 10:00:20 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-10-16T10:00:20.998424173Z 10:00:20 performance_worker.1 | Server: bce9365d53e0, Context: sidekiq, Role: background, data: {cpu: {one_min: 6.65, five_min: 3.37, fifteen_min: 2.56}, memory: 0.22980608e9, disk: {available: 828605673472, total: 938656133120, used: 110050459648}}
2025-10-16T10:00:21.002950215Z 10:00:21 default_worker.1     | Server: bce9365d53e0, Context: sidekiq, Role: background, data: {cpu: {one_min: 6.65, five_min: 3.37, fifteen_min: 2.56}, memory: 0.230617088e9, disk: {available: 828605050880, total: 938656133120, used: 110051082240}}
2025-10-16T10:00:21.029308161Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-10-16T10:00:21.030113683Z s6-rc: info: service svc-manyfold successfully started
2025-10-16T10:00:21.030267482Z s6-rc: info: service legacy-services: starting
2025-10-16T10:00:21.038578054Z s6-rc: info: service legacy-services successfully started
2025-10-16T10:00:21.038766734Z s6-rc: info: service ci-service-check: starting
2025-10-16T10:00:21.042378656Z [ls.io-init] done.
2025-10-16T10:00:21.043126401Z s6-rc: info: service ci-service-check successfully started
2025-10-16T10:00:21.080886443Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.080Z pid=302 tid=hoe jid=e188972833e1f2587feb1d27 class=Upgrade::GenerateSlugsJob: start
2025-10-16T10:00:21.085115919Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [147f832b-e0b2-4f1c-83a9-bce97f9bc816] Performing Upgrade::GenerateSlugsJob (Job ID: 147f832b-e0b2-4f1c-83a9-bce97f9bc816) from Sidekiq(high) enqueued at 2025-10-16T10:00:20.697159749Z 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-16T10:00:21.088009544Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.080Z pid=302 tid=ho6 jid=d3cd32c9ff12a9668a5d0f7a class=Upgrade::GenerateSlugsJob: start
2025-10-16T10:00:21.115504750Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4aefeaa1-e179-4044-a523-354bc9d39c5c] Performing Upgrade::GenerateSlugsJob (Job ID: 4aefeaa1-e179-4044-a523-354bc9d39c5c) from Sidekiq(high) enqueued at 2025-10-16T10:00:20.701335315Z 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-16T10:00:21.135383081Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.080Z pid=302 tid=hn2 jid=2d4d0951449321269c3c6dad class=Upgrade::GenerateSlugsJob: start
2025-10-16T10:00:21.179985980Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [23c7440f-aff0-47ad-ac97-103ac215e318] Performing Upgrade::GenerateSlugsJob (Job ID: 23c7440f-aff0-47ad-ac97-103ac215e318) from Sidekiq(high) enqueued at 2025-10-16T10:00:20.704329213Z 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-16T10:00:21.181538395Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.085Z pid=302 tid=hq6 jid=34c56a275e568447d293b738 class=Upgrade::FixNilFileSizeValues: start
2025-10-16T10:00:21.182644001Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f8d02960-5f45-4b4f-8248-0323038217e2] Performing Upgrade::FixNilFileSizeValues (Job ID: f8d02960-5f45-4b4f-8248-0323038217e2) from Sidekiq(upgrade) enqueued at 2025-10-16T10:00:20.707037716Z
2025-10-16T10:00:21.188164666Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4aefeaa1-e179-4044-a523-354bc9d39c5c] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.189933527Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [23c7440f-aff0-47ad-ac97-103ac215e318] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.235039028Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4aefeaa1-e179-4044-a523-354bc9d39c5c] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-16T10:00:21.243930418Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4aefeaa1-e179-4044-a523-354bc9d39c5c] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.016
2025-10-16T10:00:21.279916239Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [23c7440f-aff0-47ad-ac97-103ac215e318] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-16T10:00:21.295524793Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [23c7440f-aff0-47ad-ac97-103ac215e318] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.036
2025-10-16T10:00:21.295835108Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f8d02960-5f45-4b4f-8248-0323038217e2] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.424675051Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f8d02960-5f45-4b4f-8248-0323038217e2] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-16T10:00:21.426422068Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f8d02960-5f45-4b4f-8248-0323038217e2] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.097
2025-10-16T10:00:21.439840002Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [147f832b-e0b2-4f1c-83a9-bce97f9bc816] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.529813996Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [147f832b-e0b2-4f1c-83a9-bce97f9bc816] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-16T10:00:21.530176125Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [147f832b-e0b2-4f1c-83a9-bce97f9bc816] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.084
2025-10-16T10:00:21.583242934Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4aefeaa1-e179-4044-a523-354bc9d39c5c] Performed Upgrade::GenerateSlugsJob (Job ID: 4aefeaa1-e179-4044-a523-354bc9d39c5c) from Sidekiq(high) in 473.14ms
2025-10-16T10:00:21.590299772Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [23c7440f-aff0-47ad-ac97-103ac215e318] Performed Upgrade::GenerateSlugsJob (Job ID: 23c7440f-aff0-47ad-ac97-103ac215e318) from Sidekiq(high) in 450.73ms
2025-10-16T10:00:21.594243221Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.590Z pid=302 tid=ho6 jid=d3cd32c9ff12a9668a5d0f7a class=Upgrade::GenerateSlugsJob elapsed=0.51: done
2025-10-16T10:00:21.594775082Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f8d02960-5f45-4b4f-8248-0323038217e2] Performed Upgrade::FixNilFileSizeValues (Job ID: f8d02960-5f45-4b4f-8248-0323038217e2) from Sidekiq(upgrade) in 408.48ms
2025-10-16T10:00:21.595195769Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.594Z pid=302 tid=hn2 jid=2d4d0951449321269c3c6dad class=Upgrade::GenerateSlugsJob elapsed=0.513: done
2025-10-16T10:00:21.595225950Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [147f832b-e0b2-4f1c-83a9-bce97f9bc816] Performed Upgrade::GenerateSlugsJob (Job ID: 147f832b-e0b2-4f1c-83a9-bce97f9bc816) from Sidekiq(high) in 512.82ms
2025-10-16T10:00:21.595880718Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.594Z pid=302 tid=ho6 jid=33098161a25a73d4d5d9c87b class=Upgrade::BackfillDataPackages: start
2025-10-16T10:00:21.605906964Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [954ce8ec-52d8-4b01-86ea-fd03132a1fe5] Performing Upgrade::BackfillDataPackages (Job ID: 954ce8ec-52d8-4b01-86ea-fd03132a1fe5) from Sidekiq(upgrade) enqueued at 2025-10-16T10:00:20.708138012Z
2025-10-16T10:00:21.606787877Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.595Z pid=302 tid=hq6 jid=34c56a275e568447d293b738 class=Upgrade::FixNilFileSizeValues elapsed=0.51: done
2025-10-16T10:00:21.606803078Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.595Z pid=302 tid=hn2 jid=f5e133976ab40b1e8dd88056 class=Upgrade::DisambiguateUsernamesJob: start
2025-10-16T10:00:21.608375393Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [6512f0dc-cc8f-49b3-9597-1ae773dc7403] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 6512f0dc-cc8f-49b3-9597-1ae773dc7403) from Sidekiq(upgrade) enqueued at 2025-10-16T10:00:20.709104567Z
2025-10-16T10:00:21.609086455Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.608Z pid=302 tid=hq6 jid=1a399ef716818ebfd6ccf041 class=Upgrade::UpdateActorsJob: start
2025-10-16T10:00:21.616280388Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [954ce8ec-52d8-4b01-86ea-fd03132a1fe5] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.679191046Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.603Z pid=302 tid=hoe jid=e188972833e1f2587feb1d27 class=Upgrade::GenerateSlugsJob elapsed=0.523: done
2025-10-16T10:00:21.711989459Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [b36236be-2ddb-48fc-9823-b0308e7209b9] Performing Upgrade::UpdateActorsJob (Job ID: b36236be-2ddb-48fc-9823-b0308e7209b9) from Sidekiq(upgrade) enqueued at 2025-10-16T10:00:20.710145293Z
2025-10-16T10:00:21.770967148Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.712Z pid=302 tid=hoe jid=a0aecebc16026093f0e2a952 class=Upgrade::FixParentCollections: start
2025-10-16T10:00:21.818681080Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [6512f0dc-cc8f-49b3-9597-1ae773dc7403] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.866391024Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [fdbc7719-c398-489b-969b-9bb15cef8a9a] Performing Upgrade::FixParentCollections (Job ID: fdbc7719-c398-489b-969b-9bb15cef8a9a) from Sidekiq(upgrade) enqueued at 2025-10-16T10:00:20.711166659Z
2025-10-16T10:00:21.870606952Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [b36236be-2ddb-48fc-9823-b0308e7209b9] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.970523053Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [954ce8ec-52d8-4b01-86ea-fd03132a1fe5] Performed Upgrade::BackfillDataPackages (Job ID: 954ce8ec-52d8-4b01-86ea-fd03132a1fe5) from Sidekiq(upgrade) in 366.4ms
2025-10-16T10:00:21.983295498Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [fdbc7719-c398-489b-969b-9bb15cef8a9a] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:21.997488743Z 10:00:21 default_worker.1     | INFO  2025-10-16T10:00:21.985Z pid=302 tid=ho6 jid=33098161a25a73d4d5d9c87b class=Upgrade::BackfillDataPackages elapsed=0.389: done
2025-10-16T10:00:21.998184794Z 10:00:21 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [6512f0dc-cc8f-49b3-9597-1ae773dc7403] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 6512f0dc-cc8f-49b3-9597-1ae773dc7403) from Sidekiq(upgrade) in 390.47ms
2025-10-16T10:00:22.017153954Z 10:00:22 default_worker.1     | INFO  2025-10-16T10:00:22.014Z pid=302 tid=ho6 jid=211810f250485849b7f87ccc class=Upgrade::PruneOrphanedProblems: start
2025-10-16T10:00:22.034699930Z 10:00:22 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d] Performing Upgrade::PruneOrphanedProblems (Job ID: e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d) from Sidekiq(upgrade) enqueued at 2025-10-16T10:00:20.712149287Z
2025-10-16T10:00:22.035814323Z 10:00:22 default_worker.1     | INFO  2025-10-16T10:00:22.023Z pid=302 tid=hn2 jid=f5e133976ab40b1e8dd88056 class=Upgrade::DisambiguateUsernamesJob elapsed=0.428: done
2025-10-16T10:00:22.036430744Z 10:00:22 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [b36236be-2ddb-48fc-9823-b0308e7209b9] Performed Upgrade::UpdateActorsJob (Job ID: b36236be-2ddb-48fc-9823-b0308e7209b9) from Sidekiq(upgrade) in 419.17ms
2025-10-16T10:00:22.046399374Z 10:00:22 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [fdbc7719-c398-489b-969b-9bb15cef8a9a] Performed Upgrade::FixParentCollections (Job ID: fdbc7719-c398-489b-969b-9bb15cef8a9a) from Sidekiq(upgrade) in 230.83ms
2025-10-16T10:00:22.052924912Z 10:00:22 default_worker.1     | INFO  2025-10-16T10:00:22.052Z pid=302 tid=hq6 jid=1a399ef716818ebfd6ccf041 class=Upgrade::UpdateActorsJob elapsed=0.444: done
2025-10-16T10:00:22.052949401Z 10:00:22 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-16T10:00:22.065571723Z 10:00:22 default_worker.1     | INFO  2025-10-16T10:00:22.052Z pid=302 tid=hoe jid=a0aecebc16026093f0e2a952 class=Upgrade::FixParentCollections elapsed=0.341: done
2025-10-16T10:00:22.226209886Z 10:00:22 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-16T10:00:22.228995995Z 10:00:22 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.160
2025-10-16T10:00:22.247101727Z 10:00:22 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d] Performed Upgrade::PruneOrphanedProblems (Job ID: e08fdeee-8f3a-48f4-95ee-d5aa7d5bbe6d) from Sidekiq(upgrade) in 214.53ms
2025-10-16T10:00:22.248592779Z 10:00:22 default_worker.1     | INFO  2025-10-16T10:00:22.247Z pid=302 tid=ho6 jid=211810f250485849b7f87ccc class=Upgrade::PruneOrphanedProblems elapsed=0.233: done
2025-10-16T10:00:50.668940387Z 10:00:50 rails.1              | [91a729cb-eac6-4379-ba78-daec2133149d] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1391,"duration":15.88,"view":0.0,"db":2.52,"@timestamp":"2025-10-16T10:00:50.668Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-16T10:00:51.706320640Z 10:00:51 rails.1              | [08f90ff5-1882-45f3-a9d0-053c9828727e] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":123481,"duration":1016.99,"view":0.0,"db":25.1,"location":"http://172.17.0.5:3214/","@timestamp":"2025-10-16T10:00:51.705Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-16T10:00:51.792078878Z 10:00:51 rails.1              | [4babfe05-f7d7-4e8a-afea-b018cf25a4ea] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1089,"duration":53.6,"view":0.0,"db":3.28,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-10-16T10:00:51.771Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-16T10:00:52.501241289Z 10:00:52 rails.1              | [bcda8287-f811-4d99-adab-257ff499cfd6] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24036,"duration":677.57,"view":537.8,"db":54.91,"@timestamp":"2025-10-16T10:00:52.499Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-10-16T10:00:52.572434262Z 10:00:52 rails.1              | [ab70bae2-384d-4a32-8724-5a19b1019879] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1178,"duration":30.58,"view":0.0,"db":4.42,"@timestamp":"2025-10-16T10:00:52.570Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-16T10:00:52.895295942Z 10:00:52 rails.1              | [5a9efbc9-a780-4b90-b334-947c5832dd90] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14492,"duration":243.21,"view":0.0,"db":2.09,"location":"http://172.17.0.5:3214/","@timestamp":"2025-10-16T10:00:52.894Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-16T10:00:52.998481636Z 10:00:52 rails.1              | [ddf4a0ff-6140-4f55-bc7b-bb3684d68666] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1087,"duration":44.57,"view":0.0,"db":4.13,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-10-16T10:00:52.949Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-16T10:00:53.385261663Z 10:00:53 rails.1              | [38eeb31a-a79e-4d12-b8f5-9054176dd251] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24192,"duration":362.47,"view":221.23,"db":1.19,"@timestamp":"2025-10-16T10:00:53.380Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}