2025-10-09T14:27:38.918695610Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-10-09T14:27:38.918737985Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-10-09T14:27:38.961956922Z [mod-init] Running Docker Modification Logic
2025-10-09T14:27:39.287618372Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-10-09T14:27:40.885033014Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-10-09T14:27:41.168773571Z [mod-init] Installing linuxserver/mods:universal-redis
2025-10-09T14:27:41.187856417Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-10-09T14:27:41.188956442Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-10-09T14:27:41.206781545Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-10-09T14:27:41.230907105Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-10-09T14:27:41.231074582Z s6-rc: info: service fix-attrs: starting
2025-10-09T14:27:41.231285266Z s6-rc: info: service init-migrations: starting
2025-10-09T14:27:41.231587766Z s6-rc: info: service init-envfile: starting
2025-10-09T14:27:41.238818595Z [migrations] started
2025-10-09T14:27:41.238913146Z [migrations] no migrations found
2025-10-09T14:27:41.246013533Z s6-rc: info: service fix-attrs successfully started
2025-10-09T14:27:41.246121190Z s6-rc: info: service legacy-cont-init: starting
2025-10-09T14:27:41.258352099Z s6-rc: info: service init-migrations successfully started
2025-10-09T14:27:41.258499496Z s6-rc: info: service init-adduser: starting
2025-10-09T14:27:41.275458294Z s6-rc: info: service init-envfile successfully started
2025-10-09T14:27:41.278359095Z s6-rc: info: service legacy-cont-init successfully started
2025-10-09T14:27:42.109240719Z usermod: no changes
2025-10-09T14:27:42.240102876Z ───────────────────────────────────────
2025-10-09T14:27:42.240118097Z 
2025-10-09T14:27:42.240122275Z       ██╗     ███████╗██╗ ██████╗
2025-10-09T14:27:42.240126253Z       ██║     ██╔════╝██║██╔═══██╗
2025-10-09T14:27:42.240130111Z       ██║     ███████╗██║██║   ██║
2025-10-09T14:27:42.240134199Z       ██║     ╚════██║██║██║   ██║
2025-10-09T14:27:42.240137967Z       ███████╗███████║██║╚██████╔╝
2025-10-09T14:27:42.240141734Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-10-09T14:27:42.240145472Z 
2025-10-09T14:27:42.240149410Z    Brought to you by linuxserver.io
2025-10-09T14:27:42.240170813Z ───────────────────────────────────────
2025-10-09T14:27:42.240954311Z 
2025-10-09T14:27:42.240965152Z To support LSIO projects visit:
2025-10-09T14:27:42.240969401Z https://www.linuxserver.io/donate/
2025-10-09T14:27:42.240973088Z 
2025-10-09T14:27:42.240976656Z ───────────────────────────────────────
2025-10-09T14:27:42.240980654Z GID/UID
2025-10-09T14:27:42.240984281Z ───────────────────────────────────────
2025-10-09T14:27:42.248648083Z 
2025-10-09T14:27:42.248660718Z User UID:    911
2025-10-09T14:27:42.248665187Z User GID:    911
2025-10-09T14:27:42.248669105Z ───────────────────────────────────────
2025-10-09T14:27:42.251919049Z Linuxserver.io version: v0.125.0-pkg-3ef82d99-dev-69a93b6072d716d067db1298362e5f31bfd6d3a4-pr-15
2025-10-09T14:27:42.252507203Z Build-date: 2025-10-09T14:15:22+00:00
2025-10-09T14:27:42.252512474Z ───────────────────────────────────────
2025-10-09T14:27:42.252516482Z     
2025-10-09T14:27:42.278128746Z s6-rc: info: service init-adduser successfully started
2025-10-09T14:27:42.278370252Z s6-rc: info: service init-device-perms: starting
2025-10-09T14:27:42.286532918Z s6-rc: info: service init-device-perms successfully started
2025-10-09T14:27:42.286746939Z s6-rc: info: service init-os-end: starting
2025-10-09T14:27:42.288149854Z s6-rc: info: service init-os-end successfully started
2025-10-09T14:27:42.288332071Z s6-rc: info: service init-manyfold-config: starting
2025-10-09T14:27:42.288511362Z s6-rc: info: service init-config: starting
2025-10-09T14:27:42.290232228Z s6-rc: info: service init-config successfully started
2025-10-09T14:27:42.290402811Z s6-rc: info: service init-crontab-config: starting
2025-10-09T14:27:42.293283111Z **** SECRET_KEY_BASE set in environment. ****
2025-10-09T14:27:42.299444307Z s6-rc: info: service init-crontab-config successfully started
2025-10-09T14:27:42.316221881Z **** Running Manyfold database init. ****
2025-10-09T14:27:44.744273826Z `/root` is not writable.
2025-10-09T14:27:44.744437085Z Bundler will use `/tmp/bundler20251009-173-wy7kn8173' as your home directory temporarily.
2025-10-09T14:27:55.919493627Z Server: 96304c261f62, Context: rails, Role: web, data: {cpu: {one_min: 4.56, five_min: 2.54, fifteen_min: 2.18}, memory: 0.213815296e9, disk: {available: 829577875456, total: 938656133120, used: 109078257664}}
2025-10-09T14:27:55.919528527Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-10-09T14:27:55.919551062Z INFO  2025-10-09T14:27:53.740Z pid=173 tid=2id: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-09T14:27:55.919555401Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-10-09T14:27:55.919559359Z Migrating to CreateLibraries (20210130201037)
2025-10-09T14:27:55.919563297Z == 20210130201037 CreateLibraries: migrating ==================================
2025-10-09T14:27:55.919566954Z -- create_table(:libraries)
2025-10-09T14:27:55.919570582Z    -> 0.0032s
2025-10-09T14:27:55.919574209Z == 20210130201037 CreateLibraries: migrated (0.0032s) =========================
2025-10-09T14:27:55.919577836Z 
2025-10-09T14:27:55.919581624Z Migrating to CreateModels (20210130203243)
2025-10-09T14:27:55.919585572Z == 20210130203243 CreateModels: migrating =====================================
2025-10-09T14:27:55.919589189Z -- create_table(:models)
2025-10-09T14:27:55.919592716Z    -> 0.0010s
2025-10-09T14:27:55.919596414Z == 20210130203243 CreateModels: migrated (0.0011s) ============================
2025-10-09T14:27:55.919600011Z 
2025-10-09T14:27:55.919603488Z Migrating to CreateParts (20210205230918)
2025-10-09T14:27:55.919607065Z == 20210205230918 CreateParts: migrating ======================================
2025-10-09T14:27:55.919610682Z -- create_table(:parts)
2025-10-09T14:27:55.919614490Z    -> 0.0036s
2025-10-09T14:27:55.919618057Z == 20210205230918 CreateParts: migrated (0.0036s) =============================
2025-10-09T14:27:55.919621675Z 
2025-10-09T14:27:55.919625162Z Migrating to AddFieldsToParts (20210210153744)
2025-10-09T14:27:55.919628929Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-10-09T14:27:55.919632787Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-10-09T14:27:55.919636795Z    -> 0.0008s
2025-10-09T14:27:55.919640332Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-10-09T14:27:55.919643929Z    -> 0.0003s
2025-10-09T14:27:55.919647466Z == 20210210153744 AddFieldsToParts: migrated (0.0012s) ========================
2025-10-09T14:27:55.919651334Z 
2025-10-09T14:27:55.919655042Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-10-09T14:27:55.919658599Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-10-09T14:27:55.919662186Z -- create_table(:tags, {id: :integer})
2025-10-09T14:27:55.919665703Z    -> 0.0041s
2025-10-09T14:27:55.919669681Z -- create_table(:taggings, {id: :integer})
2025-10-09T14:27:55.919673339Z    -> 0.0021s
2025-10-09T14:27:55.919681715Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-09T14:27:55.919685443Z    -> 0.0002s
2025-10-09T14:27:55.919689992Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-09T14:27:55.919693890Z    -> 0.0021s
2025-10-09T14:27:55.919697427Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0087s) ===============
2025-10-09T14:27:55.919701064Z 
2025-10-09T14:27:55.919704581Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-10-09T14:27:55.919708449Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-10-09T14:27:55.919712057Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-10-09T14:27:55.919715724Z    -> 0.0004s
2025-10-09T14:27:55.919719331Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-09T14:27:55.919723670Z    -> 0.0004s
2025-10-09T14:27:55.919727207Z -- remove_foreign_key(:taggings, :tags)
2025-10-09T14:27:55.919730764Z    -> 0.1773s
2025-10-09T14:27:55.919734321Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-09T14:27:55.919737969Z    -> 0.0153s
2025-10-09T14:27:55.919741486Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-10-09T14:27:55.919745133Z    -> 0.0002s
2025-10-09T14:27:55.919748670Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-10-09T14:27:55.919752488Z    -> 0.0052s
2025-10-09T14:27:55.919756035Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-10-09T14:27:55.919759692Z    -> 0.0714s
2025-10-09T14:27:55.919763580Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3038s) =================
2025-10-09T14:27:55.919767208Z 
2025-10-09T14:27:55.919770685Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-10-09T14:27:55.919774442Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-10-09T14:27:55.919778270Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-10-09T14:27:55.919781937Z    -> 0.0357s
2025-10-09T14:27:55.919785534Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1154s) ===========
2025-10-09T14:27:55.919789132Z 
2025-10-09T14:27:55.919793270Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-10-09T14:27:55.919797298Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-10-09T14:27:55.919801467Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-10-09T14:27:55.919805825Z    -> 0.0003s
2025-10-09T14:27:55.919814393Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-10-09T14:27:55.919818010Z 
2025-10-09T14:27:55.919821637Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-10-09T14:27:55.919825545Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-10-09T14:27:55.919829533Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0010s) ==============
2025-10-09T14:27:55.919833501Z 
2025-10-09T14:27:55.919837499Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-10-09T14:27:55.919841337Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-10-09T14:27:55.919855706Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-09T14:27:55.919861367Z    -> 0.0078s
2025-10-09T14:27:55.919865465Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-10-09T14:27:55.919869343Z    -> 0.0002s
2025-10-09T14:27:55.919873502Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-09T14:27:55.919877500Z    -> 0.0056s
2025-10-09T14:27:55.919881257Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-10-09T14:27:55.919885085Z    -> 0.0012s
2025-10-09T14:27:55.919888612Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-09T14:27:55.919892750Z    -> 0.0004s
2025-10-09T14:27:55.919896518Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-10-09T14:27:55.919900736Z    -> 0.0001s
2025-10-09T14:27:55.919904554Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-09T14:27:55.919908753Z    -> 0.0039s
2025-10-09T14:27:55.919912270Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-10-09T14:27:55.919915927Z    -> 0.0002s
2025-10-09T14:27:55.919919604Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-09T14:27:55.919923462Z    -> 0.0005s
2025-10-09T14:27:55.919927320Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-10-09T14:27:55.919930997Z    -> 0.0001s
2025-10-09T14:27:55.919934805Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-09T14:27:55.919938553Z    -> 0.0006s
2025-10-09T14:27:55.919942070Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-10-09T14:27:55.919946088Z    -> 0.0001s
2025-10-09T14:27:55.919949615Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-09T14:27:55.919958403Z    -> 0.0015s
2025-10-09T14:27:55.919961990Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-10-09T14:27:55.919965657Z    -> 0.0002s
2025-10-09T14:27:55.919969555Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0228s) =============
2025-10-09T14:27:55.919973433Z 
2025-10-09T14:27:55.919976890Z Migrating to AddPreviewPartToModel (20210220204055)
2025-10-09T14:27:55.919980728Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-10-09T14:27:55.919984305Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-10-09T14:27:55.919987922Z    -> 0.2498s
2025-10-09T14:27:55.919991429Z == 20210220204055 AddPreviewPartToModel: migrated (0.2499s) ===================
2025-10-09T14:27:55.919995016Z 
2025-10-09T14:27:55.919998503Z Migrating to CreateCreators (20210225232756)
2025-10-09T14:27:55.920002261Z == 20210225232756 CreateCreators: migrating ===================================
2025-10-09T14:27:55.920006089Z -- create_table(:creators)
2025-10-09T14:27:55.920009626Z    -> 0.0136s
2025-10-09T14:27:55.920013133Z == 20210225232756 CreateCreators: migrated (0.0136s) ==========================
2025-10-09T14:27:55.920016720Z 
2025-10-09T14:27:55.920020458Z Migrating to AddCreatorToModels (20210225232841)
2025-10-09T14:27:55.920024155Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-10-09T14:27:55.920027782Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-10-09T14:27:55.920031370Z    -> 0.0521s
2025-10-09T14:27:55.920034897Z == 20210225232841 AddCreatorToModels: migrated (0.0521s) ======================
2025-10-09T14:27:55.920038484Z 
2025-10-09T14:27:55.920041931Z Migrating to CreateLinks (20210301230017)
2025-10-09T14:27:55.920045478Z == 20210301230017 CreateLinks: migrating ======================================
2025-10-09T14:27:55.920049065Z -- create_table(:links)
2025-10-09T14:27:55.920052582Z    -> 0.0009s
2025-10-09T14:27:55.920056109Z == 20210301230017 CreateLinks: migrated (0.0010s) =============================
2025-10-09T14:27:55.920059707Z 
2025-10-09T14:27:55.920063174Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-10-09T14:27:55.920066741Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-10-09T14:27:55.920070328Z -- remove_column(:creators, :thingiverse_user, :string)
2025-10-09T14:27:55.920073895Z    -> 0.0649s
2025-10-09T14:27:55.920077412Z -- remove_column(:creators, :cults3d_user, :string)
2025-10-09T14:27:55.920080969Z    -> 0.0041s
2025-10-09T14:27:55.920089206Z -- remove_column(:creators, :mmf_user, :string)
2025-10-09T14:27:55.920092793Z    -> 0.0135s
2025-10-09T14:27:55.920096300Z -- remove_column(:creators, :cgtrader_user, :string)
2025-10-09T14:27:55.920100278Z    -> 0.0037s
2025-10-09T14:27:55.920104346Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0883s) ==============
2025-10-09T14:27:55.920107934Z 
2025-10-09T14:27:55.920111391Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-10-09T14:27:55.920115188Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-10-09T14:27:55.920118796Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-10-09T14:27:55.920122383Z    -> 0.0541s
2025-10-09T14:27:55.920127543Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0541s) ==
2025-10-09T14:27:55.920131181Z 
2025-10-09T14:27:55.920135018Z Migrating to AddYUpToParts (20210318202638)
2025-10-09T14:27:55.920138555Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-10-09T14:27:55.920142133Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-10-09T14:27:55.920145710Z    -> 0.0153s
2025-10-09T14:27:55.920149257Z == 20210318202638 AddYUpToParts: migrated (0.0154s) ===========================
2025-10-09T14:27:55.920152854Z 
2025-10-09T14:27:55.920156301Z Migrating to CreateImages (20210321164508)
2025-10-09T14:27:55.920159848Z == 20210321164508 CreateImages: migrating =====================================
2025-10-09T14:27:55.920163435Z -- create_table(:images)
2025-10-09T14:27:55.920167113Z    -> 0.0219s
2025-10-09T14:27:55.920170790Z == 20210321164508 CreateImages: migrated (0.0220s) ============================
2025-10-09T14:27:55.920174688Z 
2025-10-09T14:27:55.920178175Z Migrating to CreateDelayedJobs (20210330215825)
2025-10-09T14:27:55.920182043Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-10-09T14:27:55.920185740Z -- create_table(:delayed_jobs)
2025-10-09T14:27:55.920189338Z    -> 0.0093s
2025-10-09T14:27:56.694085104Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-10-09T14:27:56.694126387Z    -> 0.0002s
2025-10-09T14:27:56.694136307Z == 20210330215825 CreateDelayedJobs: migrated (0.0096s) =======================
2025-10-09T14:27:56.694145736Z 
2025-10-09T14:27:56.694153942Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-10-09T14:27:56.694162289Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-10-09T14:27:56.694170836Z -- rename_table(:parts, :model_files)
2025-10-09T14:27:56.694179113Z    -> 0.0018s
2025-10-09T14:27:56.694220276Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-10-09T14:27:56.694229034Z    -> 0.0346s
2025-10-09T14:27:56.694237040Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0365s) =================
2025-10-09T14:27:56.694245747Z 
2025-10-09T14:27:56.694253763Z Migrating to RemoveImagesTable (20220106220519)
2025-10-09T14:27:56.694261920Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-10-09T14:27:56.694270247Z -- drop_table(:images)
2025-10-09T14:27:56.694278333Z    -> 0.0003s
2025-10-09T14:27:56.694286319Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-10-09T14:27:56.694294706Z 
2025-10-09T14:27:56.694302542Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-10-09T14:27:56.694311009Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-10-09T14:27:56.694319305Z -- table_exists?(:active_storage_blobs)
2025-10-09T14:27:56.694327442Z    -> 0.0001s
2025-10-09T14:27:56.694335378Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-10-09T14:27:56.694343644Z 
2025-10-09T14:27:56.694351440Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-10-09T14:27:56.694359456Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-10-09T14:27:56.694367923Z -- table_exists?(:active_storage_blobs)
2025-10-09T14:27:56.694375949Z    -> 0.0002s
2025-10-09T14:27:56.694383915Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0002s) =======
2025-10-09T14:27:56.694392002Z 
2025-10-09T14:27:56.694399727Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-10-09T14:27:56.694407783Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-10-09T14:27:56.694415840Z -- table_exists?(:active_storage_blobs)
2025-10-09T14:27:56.694423786Z    -> 0.0001s
2025-10-09T14:27:56.694431692Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-10-09T14:27:56.694439958Z 
2025-10-09T14:27:56.694448125Z Migrating to DeviseCreateUsers (20220614210023)
2025-10-09T14:27:56.694456602Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-10-09T14:27:56.694464718Z -- create_table(:users)
2025-10-09T14:27:56.694472594Z    -> 0.0012s
2025-10-09T14:27:56.694480710Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-10-09T14:27:56.694488997Z    -> 0.0016s
2025-10-09T14:27:56.694497033Z == 20220614210023 DeviseCreateUsers: migrated (0.0029s) =======================
2025-10-09T14:27:56.694516001Z 
2025-10-09T14:27:56.694524058Z Migrating to AddUsernameToUsers (20220614211256)
2025-10-09T14:27:56.694532244Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-10-09T14:27:56.694541643Z -- add_column(:users, :username, :string, {null: false})
2025-10-09T14:27:56.694550280Z    -> 0.0224s
2025-10-09T14:27:56.694558427Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-10-09T14:27:56.694566724Z    -> 0.0002s
2025-10-09T14:27:56.694574710Z == 20220614211256 AddUsernameToUsers: migrated (0.0226s) ======================
2025-10-09T14:27:56.694583157Z 
2025-10-09T14:27:56.694590952Z Migrating to AddAdminToUsers (20220614213902)
2025-10-09T14:27:56.694598868Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-10-09T14:27:56.694606944Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-09T14:27:56.694615001Z    -> 0.0007s
2025-10-09T14:27:56.694623147Z == 20220614213902 AddAdminToUsers: migrated (0.0008s) =========================
2025-10-09T14:27:56.694631203Z 
2025-10-09T14:27:56.694638959Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-10-09T14:27:56.694647055Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-10-09T14:27:56.694655412Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-10-09T14:27:56.694664661Z    -> 0.0011s
2025-10-09T14:27:56.694672727Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0011s) =============
2025-10-09T14:27:56.694681324Z 
2025-10-09T14:27:56.694689270Z Migrating to CreateSettings (20220619174307)
2025-10-09T14:27:56.694697357Z == 20220619174307 CreateSettings: migrating ===================================
2025-10-09T14:27:56.694705343Z -- create_table(:settings)
2025-10-09T14:27:56.694713299Z    -> 0.0026s
2025-10-09T14:27:56.694721255Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-10-09T14:27:56.694730042Z    -> 0.0002s
2025-10-09T14:27:56.694738159Z == 20220619174307 CreateSettings: migrated (0.0029s) ==========================
2025-10-09T14:27:56.694746636Z 
2025-10-09T14:27:56.694754662Z Migrating to AddScaleFactorToModels (20220626152444)
2025-10-09T14:27:56.694762638Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-10-09T14:27:56.694770694Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-10-09T14:27:56.694779141Z    -> 0.0109s
2025-10-09T14:27:56.694787127Z == 20220626152444 AddScaleFactorToModels: migrated (0.0133s) ==================
2025-10-09T14:27:56.694804643Z 
2025-10-09T14:27:56.694812549Z Migrating to AddDigestToModelFiles (20220702202932)
2025-10-09T14:27:56.694820675Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-10-09T14:27:56.694829062Z -- add_column(:model_files, :digest, :string)
2025-10-09T14:27:56.694837158Z    -> 0.0027s
2025-10-09T14:27:56.694845234Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-10-09T14:27:56.694854513Z    -> 0.0002s
2025-10-09T14:27:56.694862810Z == 20220702202932 AddDigestToModelFiles: migrated (0.0051s) ===================
2025-10-09T14:27:56.694870926Z 
2025-10-09T14:27:56.694878652Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-10-09T14:27:56.694886888Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-10-09T14:27:56.694895776Z -- 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-09T14:27:56.694909213Z    -> 0.0009s
2025-10-09T14:27:56.694917209Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0013s) ==============
2025-10-09T14:27:56.694925486Z 
2025-10-09T14:27:56.694933342Z Migrating to CreateProblems (20221210001132)
2025-10-09T14:27:56.694941318Z == 20221210001132 CreateProblems: migrating ===================================
2025-10-09T14:27:56.694949775Z -- create_table(:problems)
2025-10-09T14:27:56.694958232Z    -> 0.0009s
2025-10-09T14:27:56.694966138Z == 20221210001132 CreateProblems: migrated (0.0013s) ==========================
2025-10-09T14:27:56.694974434Z 
2025-10-09T14:27:56.694982350Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-10-09T14:27:56.694990557Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-10-09T14:27:56.694998994Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0177s) ========
2025-10-09T14:27:56.695007241Z 
2025-10-09T14:27:56.695015637Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-10-09T14:27:56.695023944Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-10-09T14:27:56.695032181Z -- create_table(:favorites, {force: true})
2025-10-09T14:27:56.695040788Z    -> 0.0042s
2025-10-09T14:27:56.695048864Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-10-09T14:27:56.695057963Z    -> 0.0001s
2025-10-09T14:27:56.695066380Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-10-09T14:27:56.695084977Z    -> 0.0001s
2025-10-09T14:27:56.695093083Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-10-09T14:27:56.695102733Z    -> 0.0001s
2025-10-09T14:27:56.695111009Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0051s) ================
2025-10-09T14:27:56.695119226Z 
2025-10-09T14:27:56.695127032Z Migrating to MovePrintedToFavorites (20221220223040)
2025-10-09T14:27:56.695135489Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-10-09T14:27:56.695143615Z == 20221220223040 MovePrintedToFavorites: migrated (0.0715s) ==================
2025-10-09T14:27:56.695151671Z 
2025-10-09T14:27:56.695159477Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-10-09T14:27:56.695167573Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-10-09T14:27:56.695175670Z -- remove_column(:model_files, :printed, :boolean)
2025-10-09T14:27:56.695183676Z    -> 0.0309s
2025-10-09T14:27:56.695191592Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0314s) ===============
2025-10-09T14:27:56.695199798Z 
2025-10-09T14:27:56.695207504Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-10-09T14:27:56.695216061Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-10-09T14:27:56.695225570Z -- add_column(:models, :notes, :text)
2025-10-09T14:27:56.695233566Z    -> 0.0012s
2025-10-09T14:27:56.695241512Z -- add_column(:models, :excerpt, :text)
2025-10-09T14:27:56.695249478Z    -> 0.0025s
2025-10-09T14:27:56.695257384Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0038s) =================
2025-10-09T14:27:56.695265982Z 
2025-10-09T14:27:56.695274118Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-10-09T14:27:56.695282144Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-10-09T14:27:56.695290200Z -- add_column(:creators, :notes, :text)
2025-10-09T14:27:56.695298176Z    -> 0.0006s
2025-10-09T14:27:56.695306052Z -- add_column(:creators, :excerpt, :text)
2025-10-09T14:27:56.695313998Z    -> 0.0005s
2025-10-09T14:27:56.695321894Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0011s) ===============
2025-10-09T14:27:56.695330301Z 
2025-10-09T14:27:56.695338257Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-10-09T14:27:56.695346915Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-10-09T14:27:56.695354961Z -- add_column(:model_files, :notes, :text)
2025-10-09T14:27:56.695362927Z    -> 0.0006s
2025-10-09T14:27:56.695380182Z -- add_column(:model_files, :excerpt, :text)
2025-10-09T14:27:56.695388168Z    -> 0.0005s
2025-10-09T14:27:56.695396063Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0011s) =============
2025-10-09T14:27:56.695404390Z 
2025-10-09T14:27:56.695412156Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-10-09T14:27:56.695420122Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-10-09T14:27:56.695428188Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0235s) =================
2025-10-09T14:27:56.695436214Z 
2025-10-09T14:27:56.695444000Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-10-09T14:27:56.695452046Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-10-09T14:27:56.695460263Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-10-09T14:27:56.695468910Z    -> 0.0484s
2025-10-09T14:27:56.695477397Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0484s) =============
2025-10-09T14:27:56.695485704Z 
2025-10-09T14:27:56.695493680Z Migrating to RenameExcerptToCaption (20230222155910)
2025-10-09T14:27:56.695502257Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-10-09T14:27:56.695510444Z -- rename_column(:creators, :excerpt, :caption)
2025-10-09T14:27:56.695518530Z    -> 0.0235s
2025-10-09T14:27:56.695526486Z -- rename_column(:models, :excerpt, :caption)
2025-10-09T14:27:56.695534943Z    -> 0.0221s
2025-10-09T14:27:56.695542969Z -- rename_column(:model_files, :excerpt, :caption)
2025-10-09T14:27:56.695551026Z    -> 0.0213s
2025-10-09T14:27:56.695559052Z == 20230222155910 RenameExcerptToCaption: migrated (0.0697s) ==================
2025-10-09T14:27:56.695567218Z 
2025-10-09T14:27:56.695575214Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-10-09T14:27:56.695583731Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-10-09T14:27:56.695591998Z -- add_column(:libraries, :notes, :string)
2025-10-09T14:27:56.695600245Z    -> 0.0023s
2025-10-09T14:27:56.695608321Z -- add_column(:libraries, :caption, :string)
2025-10-09T14:27:57.184836794Z    -> 0.0005s
2025-10-09T14:27:57.184872145Z -- add_column(:libraries, :name, :string)
2025-10-09T14:27:57.184881754Z    -> 0.0005s
2025-10-09T14:27:57.184890101Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0128s) ============
2025-10-09T14:27:57.184898468Z 
2025-10-09T14:27:57.184906534Z Migrating to AddTagregexToLibrary (20230305180823)
2025-10-09T14:27:57.184914771Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-10-09T14:27:57.184948419Z -- add_column(:libraries, :tag_regex, :text)
2025-10-09T14:27:57.184956805Z    -> 0.0021s
2025-10-09T14:27:57.184964641Z == 20230305180823 AddTagregexToLibrary: migrated (0.0040s) ====================
2025-10-09T14:27:57.184972768Z 
2025-10-09T14:27:57.184980513Z Migrating to AddIconToLibrary (20230307215826)
2025-10-09T14:27:57.184988389Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-10-09T14:27:57.184996515Z -- add_column(:libraries, :icon, :text)
2025-10-09T14:27:57.185004502Z    -> 0.0020s
2025-10-09T14:27:57.185012417Z == 20230307215826 AddIconToLibrary: migrated (0.0038s) ========================
2025-10-09T14:27:57.185020394Z 
2025-10-09T14:27:57.185028139Z Migrating to CreateCollection (20230308004237)
2025-10-09T14:27:57.185036105Z == 20230308004237 CreateCollection: migrating =================================
2025-10-09T14:27:57.185044211Z -- create_table(:collections)
2025-10-09T14:27:57.185052097Z    -> 0.0030s
2025-10-09T14:27:57.185060073Z == 20230308004237 CreateCollection: migrated (0.0073s) ========================
2025-10-09T14:27:57.185068160Z 
2025-10-09T14:27:57.185075985Z Migrating to AddCollectionToModels (20230308005021)
2025-10-09T14:27:57.185084122Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-10-09T14:27:57.185092128Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-10-09T14:27:57.185100174Z    -> 0.0264s
2025-10-09T14:27:57.185108040Z == 20230308005021 AddCollectionToModels: migrated (0.0306s) ===================
2025-10-09T14:27:57.185116096Z 
2025-10-09T14:27:57.185123982Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-10-09T14:27:57.185131978Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-10-09T14:27:57.185140004Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0015s) =============
2025-10-09T14:27:57.185148081Z 
2025-10-09T14:27:57.185155806Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-10-09T14:27:57.185164013Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-10-09T14:27:57.185172269Z -- rename_column(:collections, :excerpt, :caption)
2025-10-09T14:27:57.185180255Z    -> 0.0041s
2025-10-09T14:27:57.185188472Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0041s) ========
2025-10-09T14:27:57.185196528Z 
2025-10-09T14:27:57.185204274Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-10-09T14:27:57.185212250Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-10-09T14:27:57.185220346Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-10-09T14:27:57.185506262Z 
2025-10-09T14:27:57.185516172Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-10-09T14:27:57.185525821Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-10-09T14:27:57.185534509Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-10-09T14:27:57.185544118Z    -> 0.0017s
2025-10-09T14:27:57.185552385Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0017s) ===============
2025-10-09T14:27:57.185560571Z 
2025-10-09T14:27:57.185568597Z Migrating to AddCollectionToCollections (20230324000000)
2025-10-09T14:27:57.185576604Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-10-09T14:27:57.185584650Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-10-09T14:27:57.185592786Z    -> 0.0063s
2025-10-09T14:27:57.185600822Z == 20230324000000 AddCollectionToCollections: migrated (0.0086s) ==============
2025-10-09T14:27:57.185608929Z 
2025-10-09T14:27:57.185616754Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-10-09T14:27:57.185624710Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-10-09T14:27:57.185632747Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0574s) =========
2025-10-09T14:27:57.185640783Z 
2025-10-09T14:27:57.185648528Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-10-09T14:27:57.185656565Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-10-09T14:27:57.185664641Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0087s) 
2025-10-09T14:27:57.185672747Z 
2025-10-09T14:27:57.185680583Z Migrating to AddSlugs (20230615135601)
2025-10-09T14:27:57.185688479Z == 20230615135601 AddSlugs: migrating =========================================
2025-10-09T14:27:57.185696665Z -- add_column(:models, :slug, :string)
2025-10-09T14:27:57.185704611Z    -> 0.0033s
2025-10-09T14:27:57.185712507Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-10-09T14:27:57.185720804Z    -> 0.0024s
2025-10-09T14:27:57.185729051Z -- add_column(:collections, :slug, :string)
2025-10-09T14:27:57.185737097Z    -> 0.0005s
2025-10-09T14:27:57.185745073Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-10-09T14:27:57.185754852Z    -> 0.0002s
2025-10-09T14:27:57.185766025Z -- add_column(:creators, :slug, :string)
2025-10-09T14:27:57.185776426Z    -> 0.0005s
2025-10-09T14:27:57.185800404Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-10-09T14:27:57.185810965Z    -> 0.0001s
2025-10-09T14:27:57.185820946Z == 20230615135601 AddSlugs: migrated (0.0077s) ================================
2025-10-09T14:27:57.185831116Z 
2025-10-09T14:27:57.185839002Z Migrating to GenerateSlugs (20230617222353)
2025-10-09T14:27:57.185846978Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-10-09T14:27:57.185856748Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-10-09T14:27:57.185866998Z 
2025-10-09T14:27:57.185876858Z Migrating to MakeNamesUnique (20230628194944)
2025-10-09T14:27:57.185886718Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-10-09T14:27:57.185897790Z == 20230628194944 MakeNamesUnique: migrated (0.0038s) =========================
2025-10-09T14:27:57.185907069Z 
2025-10-09T14:27:57.185916147Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-10-09T14:27:57.185926588Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-10-09T14:27:57.185936929Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-10-09T14:27:57.185947981Z    -> 0.0023s
2025-10-09T14:27:57.185958483Z -- remove_index(:creators, :slug)
2025-10-09T14:27:57.185968934Z    -> 0.0005s
2025-10-09T14:27:57.185978803Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-10-09T14:27:57.185988844Z    -> 0.0002s
2025-10-09T14:27:57.185998513Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-10-09T14:27:57.186008423Z    -> 0.0002s
2025-10-09T14:27:57.186018353Z -- remove_index(:collections, :slug)
2025-10-09T14:27:57.186028013Z    -> 0.0264s
2025-10-09T14:27:57.186037542Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-10-09T14:27:57.186047261Z    -> 0.0016s
2025-10-09T14:27:57.186056770Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0317s) ======
2025-10-09T14:27:57.186066791Z 
2025-10-09T14:27:57.186076580Z Migrating to AddSizeToModelFiles (20230707082403)
2025-10-09T14:27:57.186089336Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-10-09T14:27:57.186099657Z -- add_column(:model_files, :size, :integer)
2025-10-09T14:27:57.186110108Z    -> 0.0007s
2025-10-09T14:27:57.186120148Z == 20230707082403 AddSizeToModelFiles: migrated (0.0012s) =====================
2025-10-09T14:27:57.186130088Z 
2025-10-09T14:27:57.186140158Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-10-09T14:27:57.186164307Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-10-09T14:27:57.186174698Z -- change_column(:model_files, :size, :bigint)
2025-10-09T14:27:57.186185039Z    -> 0.0091s
2025-10-09T14:27:57.186194378Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0095s) ==================
2025-10-09T14:27:57.186203786Z 
2025-10-09T14:27:57.186212574Z Migrating to AddNoteToProblems (20230711111009)
2025-10-09T14:27:57.186221683Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-10-09T14:27:57.186231182Z -- add_column(:problems, :note, :string, {default: nil})
2025-10-09T14:27:57.186241462Z    -> 0.0014s
2025-10-09T14:27:57.186251743Z == 20230711111009 AddNoteToProblems: migrated (0.0025s) =======================
2025-10-09T14:27:57.186262094Z 
2025-10-09T14:27:57.186272625Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-10-09T14:27:57.186282595Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-10-09T14:27:57.186295391Z -- 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-09T14:27:57.186313738Z    -> 0.0007s
2025-10-09T14:27:57.186323989Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0008s) ================
2025-10-09T14:27:57.186334289Z 
2025-10-09T14:27:57.186343698Z Migrating to AddLicenseToModel (20240127143358)
2025-10-09T14:27:57.186351734Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-10-09T14:27:57.186359881Z -- add_column(:models, :license, :string)
2025-10-09T14:27:57.186367817Z    -> 0.0006s
2025-10-09T14:27:57.186375693Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-10-09T14:27:57.186383769Z 
2025-10-09T14:27:57.186391565Z Migrating to AddIgnoredToProblems (20240131134832)
2025-10-09T14:27:57.186399551Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-10-09T14:27:57.186408619Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-10-09T14:27:57.186419100Z    -> 0.0007s
2025-10-09T14:27:57.186429130Z == 20240131134832 AddIgnoredToProblems: migrated (0.0008s) ====================
2025-10-09T14:27:57.186439421Z 
2025-10-09T14:27:57.186447337Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-10-09T14:27:57.186455313Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-10-09T14:27:57.186475043Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-10-09T14:27:57.186483810Z    -> 0.0098s
2025-10-09T14:27:57.186493710Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0099s) ======
2025-10-09T14:27:57.186503891Z 
2025-10-09T14:27:57.186513761Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-10-09T14:27:57.186523971Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-10-09T14:27:57.186534302Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-10-09T14:27:57.186545044Z    -> 0.0007s
2025-10-09T14:27:57.186554653Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-10-09T14:27:57.186562900Z 
2025-10-09T14:27:57.186570735Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-10-09T14:27:57.186578691Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-10-09T14:27:57.186586708Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-10-09T14:27:57.186594934Z    -> 0.0002s
2025-10-09T14:27:57.186603030Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-10-09T14:27:57.186611477Z    -> 0.0010s
2025-10-09T14:27:57.186619604Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-10-09T14:27:57.186628381Z    -> 0.0001s
2025-10-09T14:27:57.186636748Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-10-09T14:27:57.186645316Z    -> 0.0045s
2025-10-09T14:27:57.731582134Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0060s) =================
2025-10-09T14:27:57.731619519Z 
2025-10-09T14:27:57.731624870Z Migrating to CreateFlipperTables (20240306095646)
2025-10-09T14:27:57.731630051Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-10-09T14:27:57.731634650Z -- create_table(:flipper_features)
2025-10-09T14:27:57.731639039Z    -> 0.0029s
2025-10-09T14:27:57.731643668Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-10-09T14:27:57.731648357Z    -> 0.0050s
2025-10-09T14:27:57.731652386Z -- create_table(:flipper_gates)
2025-10-09T14:27:57.731656474Z    -> 0.0003s
2025-10-09T14:27:57.731660512Z -- 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-09T14:27:57.731665011Z    -> 0.0001s
2025-10-09T14:27:57.731689420Z == 20240306095646 CreateFlipperTables: migrated (0.0084s) =====================
2025-10-09T14:27:57.731693919Z 
2025-10-09T14:27:57.731698188Z Migrating to RolifyCreateRoles (20240319155251)
2025-10-09T14:27:57.731702577Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-10-09T14:27:57.731707026Z -- create_table(:roles)
2025-10-09T14:27:57.731711254Z    -> 0.0430s
2025-10-09T14:27:57.731716104Z -- create_table(:users_roles, {id: false})
2025-10-09T14:27:57.731720653Z    -> 0.0007s
2025-10-09T14:27:57.731725603Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-10-09T14:27:57.731730022Z    -> 0.0051s
2025-10-09T14:27:57.731734300Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-10-09T14:27:57.731739060Z    -> 0.0002s
2025-10-09T14:27:57.731743349Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-10-09T14:27:57.731747928Z    -> 0.0001s
2025-10-09T14:27:57.731752267Z == 20240319155251 RolifyCreateRoles: migrated (0.0666s) =======================
2025-10-09T14:27:57.731756716Z 
2025-10-09T14:27:57.731760974Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-10-09T14:27:57.731765654Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-10-09T14:27:57.731770133Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0063s) ==================
2025-10-09T14:27:57.731774732Z 
2025-10-09T14:27:57.731779031Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-10-09T14:27:57.731783520Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-10-09T14:27:57.731787989Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-10-09T14:27:57.731792488Z    -> 0.0474s
2025-10-09T14:27:57.731796886Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0488s) ====================
2025-10-09T14:27:57.731801606Z 
2025-10-09T14:27:57.731806426Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-10-09T14:27:57.731810985Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-10-09T14:27:57.731815564Z -- add_column(:users, :reset_password_token, :string)
2025-10-09T14:27:57.731820083Z    -> 0.0012s
2025-10-09T14:27:57.731824713Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-10-09T14:27:57.731830214Z    -> 0.0002s
2025-10-09T14:27:57.731834813Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0036s) ============
2025-10-09T14:27:57.731840214Z 
2025-10-09T14:27:57.731855004Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-10-09T14:27:57.731866136Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-10-09T14:27:57.731870525Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0258s) ==============
2025-10-09T14:27:57.731874964Z 
2025-10-09T14:27:57.731879152Z Migrating to AddRememberableToUsers (20240410221112)
2025-10-09T14:27:57.731884062Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-10-09T14:27:57.731888531Z -- add_column(:users, :remember_created_at, :datetime)
2025-10-09T14:27:57.731892890Z    -> 0.0034s
2025-10-09T14:27:57.731897138Z == 20240410221112 AddRememberableToUsers: migrated (0.0048s) ==================
2025-10-09T14:27:57.731901567Z 
2025-10-09T14:27:57.731905886Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-10-09T14:27:57.731910365Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-10-09T14:27:57.731914814Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-10-09T14:27:57.731919283Z    -> 0.0008s
2025-10-09T14:27:57.731923531Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0022s) ===========
2025-10-09T14:27:57.731927940Z 
2025-10-09T14:27:57.731932179Z Migrating to DropDelayedJobs (20240418112821)
2025-10-09T14:27:57.731936558Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-10-09T14:27:57.731941057Z -- drop_table(:delayed_jobs)
2025-10-09T14:27:57.731945315Z    -> 0.0020s
2025-10-09T14:27:57.731949564Z == 20240418112821 DropDelayedJobs: migrated (0.0129s) =========================
2025-10-09T14:27:57.731954153Z 
2025-10-09T14:27:57.731958392Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-10-09T14:27:57.731962971Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-10-09T14:27:57.731967360Z -- add_column(:users, :interface_language, :string)
2025-10-09T14:27:57.731971678Z    -> 0.0007s
2025-10-09T14:27:57.731975967Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0044s) =============
2025-10-09T14:27:57.731980336Z 
2025-10-09T14:27:57.731984544Z Migrating to AddLockableToUsers (20240610120318)
2025-10-09T14:27:57.731989344Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-10-09T14:27:57.731994033Z -- change_table(:users)
2025-10-09T14:27:57.731998282Z    -> 0.0017s
2025-10-09T14:27:57.732002721Z == 20240610120318 AddLockableToUsers: migrated (0.0021s) ======================
2025-10-09T14:27:57.732007160Z 
2025-10-09T14:27:57.732011499Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-10-09T14:27:57.732020747Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-10-09T14:27:57.732024846Z -- add_column(:model_files, :attachment_data, :json)
2025-10-09T14:27:57.732028884Z    -> 0.0006s
2025-10-09T14:27:57.732032802Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0010s) ===========
2025-10-09T14:27:57.732037070Z 
2025-10-09T14:27:57.732041239Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-10-09T14:27:57.732045848Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-10-09T14:27:57.732050247Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0235s) ==================
2025-10-09T14:27:57.732054656Z 
2025-10-09T14:27:57.732058814Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-10-09T14:27:57.732063293Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-10-09T14:27:57.732067682Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-10-09T14:27:57.732072181Z    -> 0.0007s
2025-10-09T14:27:57.732076469Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0027s) ============
2025-10-09T14:27:57.732080969Z 
2025-10-09T14:27:57.732085107Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-10-09T14:27:57.732089466Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-10-09T14:27:57.732093975Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-10-09T14:27:57.732098424Z    -> 0.0006s
2025-10-09T14:27:57.732102732Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-10-09T14:27:57.732107031Z    -> 0.0006s
2025-10-09T14:27:57.732111310Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-10-09T14:27:57.732115799Z    -> 0.0009s
2025-10-09T14:27:57.732120037Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-10-09T14:27:57.732124566Z    -> 0.0052s
2025-10-09T14:27:57.732128815Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-10-09T14:27:57.732133394Z    -> 0.0006s
2025-10-09T14:27:57.732137603Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0092s) ====================
2025-10-09T14:27:57.732141991Z 
2025-10-09T14:27:57.732146120Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-10-09T14:27:57.732150418Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-10-09T14:27:57.732154847Z -- remove_index(:libraries, :path)
2025-10-09T14:27:57.732159096Z    -> 0.0011s
2025-10-09T14:27:57.732163625Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0019s) ================
2025-10-09T14:27:57.732168074Z 
2025-10-09T14:27:57.732177383Z Migrating to CreateFederailsActors (20240727113215)
2025-10-09T14:27:57.732181751Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-10-09T14:27:57.732186170Z -- create_table(:federails_actors)
2025-10-09T14:27:57.732190499Z    -> 0.0009s
2025-10-09T14:27:57.732194848Z -- foreign_key_exists?(:federails_actors, :users)
2025-10-09T14:27:57.732199177Z    -> 0.0016s
2025-10-09T14:27:57.732203435Z -- remove_foreign_key(:federails_actors, :users)
2025-10-09T14:27:57.732207894Z    -> 0.0122s
2025-10-09T14:27:57.732212233Z -- remove_index(:federails_actors, :user_id)
2025-10-09T14:27:57.732216471Z    -> 0.0004s
2025-10-09T14:27:57.732220429Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-10-09T14:27:57.732225239Z    -> 0.0001s
2025-10-09T14:27:57.732229157Z -- add_foreign_key(:federails_actors, :users)
2025-10-09T14:27:57.732233115Z    -> 0.0102s
2025-10-09T14:27:57.732237223Z == 20240727113215 CreateFederailsActors: migrated (0.0263s) ===================
2025-10-09T14:27:57.732241752Z 
2025-10-09T14:27:57.732245941Z Migrating to CreateFederailsFollowings (20240727113216)
2025-10-09T14:27:57.732250690Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-10-09T14:27:57.732255199Z -- create_table(:federails_followings)
2025-10-09T14:27:57.732259538Z    -> 0.0012s
2025-10-09T14:27:57.732263797Z == 20240727113216 CreateFederailsFollowings: migrated (0.0012s) ===============
2025-10-09T14:27:57.732268226Z 
2025-10-09T14:27:57.732272434Z Migrating to CreateFederailsActivities (20240727113217)
2025-10-09T14:27:57.732277124Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-10-09T14:27:57.732281943Z -- create_table(:federails_activities)
2025-10-09T14:27:57.732286292Z    -> 0.0093s
2025-10-09T14:27:57.732290671Z == 20240727113217 CreateFederailsActivities: migrated (0.0094s) ===============
2025-10-09T14:27:57.732295090Z 
2025-10-09T14:27:57.732299238Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-10-09T14:27:57.732303607Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-10-09T14:27:57.732308036Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-10-09T14:27:57.732312946Z    -> 0.0083s
2025-10-09T14:27:57.732317224Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-10-09T14:27:57.732323848Z    -> 0.0004s
2025-10-09T14:27:57.732328287Z -- change_table(:federails_actors)
2025-10-09T14:27:57.732332826Z    -> 0.0067s
2025-10-09T14:27:57.732342235Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0154s) =======
2025-10-09T14:27:57.732346423Z 
2025-10-09T14:27:57.732350501Z Migrating to CreateFederailsActors (20240731165647)
2025-10-09T14:27:57.732354870Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-10-09T14:27:57.732359479Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-10-09T14:27:57.732363878Z 
2025-10-09T14:27:57.732368027Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-10-09T14:27:57.732372345Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-10-09T14:27:57.732376744Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-10-09T14:27:57.732381123Z 
2025-10-09T14:27:57.732385241Z Migrating to BackfillActivities (20240805111500)
2025-10-09T14:27:57.732389650Z == 20240805111500 BackfillActivities: migrating ===============================
2025-10-09T14:27:57.732394029Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-10-09T14:27:57.732398398Z 
2025-10-09T14:27:57.732402907Z Migrating to CreateCaberRelations (20240827155630)
2025-10-09T14:27:57.732407236Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-10-09T14:27:57.732411634Z -- create_table(:caber_relations)
2025-10-09T14:27:57.732415923Z    -> 0.0433s
2025-10-09T14:27:57.732420272Z == 20240827155630 CreateCaberRelations: migrated (0.0433s) ====================
2025-10-09T14:27:57.732424761Z 
2025-10-09T14:27:57.732428939Z Migrating to AddDefaultAccessControls (20240830121749)
2025-10-09T14:27:57.732433589Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-10-09T14:27:57.732438258Z == 20240830121749 AddDefaultAccessControls: migrated (0.0613s) ================
2025-10-09T14:27:57.732442637Z 
2025-10-09T14:27:57.732447026Z Migrating to RenameDefaultRoles (20240830151650)
2025-10-09T14:27:58.433896792Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-10-09T14:27:58.433941001Z == 20240830151650 RenameDefaultRoles: migrated (0.0424s) ======================
2025-10-09T14:27:58.433950581Z 
2025-10-09T14:27:58.433958697Z Migrating to AddPublicIDsToModels (20240904151944)
2025-10-09T14:27:58.433966864Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-10-09T14:27:58.433975000Z -- add_column(:models, :public_id, :string)
2025-10-09T14:27:58.433983086Z    -> 0.0008s
2025-10-09T14:27:58.433991273Z -- add_index(:models, :public_id)
2025-10-09T14:27:58.433999219Z    -> 0.0028s
2025-10-09T14:27:58.434007155Z -- add_column(:model_files, :public_id, :string)
2025-10-09T14:27:58.434067476Z    -> 0.0007s
2025-10-09T14:27:58.434075442Z -- add_index(:model_files, :public_id)
2025-10-09T14:27:58.434083378Z    -> 0.0002s
2025-10-09T14:27:58.434091214Z -- add_column(:problems, :public_id, :string)
2025-10-09T14:27:58.434099110Z    -> 0.0006s
2025-10-09T14:27:58.434106996Z -- add_index(:problems, :public_id)
2025-10-09T14:27:58.434114882Z    -> 0.0001s
2025-10-09T14:27:58.434122808Z -- add_column(:creators, :public_id, :string)
2025-10-09T14:27:58.434130774Z    -> 0.0007s
2025-10-09T14:27:58.434139792Z -- add_index(:creators, :public_id)
2025-10-09T14:27:58.434149822Z    -> 0.0002s
2025-10-09T14:27:58.434160383Z -- add_column(:collections, :public_id, :string)
2025-10-09T14:27:58.434170584Z    -> 0.0007s
2025-10-09T14:27:58.434180494Z -- add_index(:collections, :public_id)
2025-10-09T14:27:58.434190424Z    -> 0.0001s
2025-10-09T14:27:58.434200133Z -- add_column(:libraries, :public_id, :string)
2025-10-09T14:27:58.434208129Z    -> 0.0007s
2025-10-09T14:27:58.434216085Z -- add_index(:libraries, :public_id)
2025-10-09T14:27:58.434223961Z    -> 0.0001s
2025-10-09T14:27:58.434233711Z == 20240904151944 AddPublicIDsToModels: migrated (0.0078s) ====================
2025-10-09T14:27:58.434245204Z 
2025-10-09T14:27:58.434256587Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-10-09T14:27:58.434267589Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-10-09T14:27:58.434277940Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:27:58.434289052Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0515s) ==============
2025-10-09T14:27:58.434299193Z 
2025-10-09T14:27:58.434308632Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-10-09T14:27:58.434318562Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-10-09T14:27:58.434328502Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-10-09T14:27:58.434338472Z 
2025-10-09T14:27:58.434348232Z Migrating to DeduplicateRoles (20240923114515)
2025-10-09T14:27:58.434358482Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-10-09T14:27:58.434368693Z == 20240923114515 DeduplicateRoles: migrated (0.1569s) ========================
2025-10-09T14:27:58.434378733Z 
2025-10-09T14:27:58.434388753Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-10-09T14:27:58.434399074Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-10-09T14:27:58.434424285Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-09T14:27:58.434434676Z    -> 0.1734s
2025-10-09T14:27:58.434444816Z -- add_index(:models, :name_lower)
2025-10-09T14:27:58.434453423Z    -> 0.0002s
2025-10-09T14:27:58.434461760Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-09T14:27:58.434470528Z    -> 0.0072s
2025-10-09T14:27:58.434478444Z -- add_index(:creators, :name_lower)
2025-10-09T14:27:58.434486500Z    -> 0.0001s
2025-10-09T14:27:58.434494706Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-10-09T14:27:58.434503083Z    -> 0.0082s
2025-10-09T14:27:58.434510939Z -- add_index(:collections, :name_lower)
2025-10-09T14:27:58.434519146Z    -> 0.0001s
2025-10-09T14:27:58.434528715Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1895s) =============
2025-10-09T14:27:58.434539326Z 
2025-10-09T14:27:58.434549256Z Migrating to AddKeypairToActors (20240926162407)
2025-10-09T14:27:58.434559978Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-10-09T14:27:58.434570158Z -- change_table(:federails_actors)
2025-10-09T14:27:58.434579938Z    -> 0.0015s
2025-10-09T14:27:58.434589708Z == 20240926162407 AddKeypairToActors: migrated (0.0015s) ======================
2025-10-09T14:27:58.434599357Z 
2025-10-09T14:27:58.434607534Z Migrating to AddUuids (20241004194445)
2025-10-09T14:27:58.434615410Z == 20241004194445 AddUuids: migrating =========================================
2025-10-09T14:27:58.434623516Z -- change_table(:federails_actors)
2025-10-09T14:27:58.434631562Z    -> 0.0031s
2025-10-09T14:27:58.434641252Z -- change_table(:federails_activities)
2025-10-09T14:27:58.434651141Z    -> 0.0009s
2025-10-09T14:27:58.434660761Z -- change_table(:federails_followings)
2025-10-09T14:27:58.434670180Z    -> 0.0009s
2025-10-09T14:27:58.434678106Z == 20241004194445 AddUuids: migrated (0.0049s) ================================
2025-10-09T14:27:58.434686122Z 
2025-10-09T14:27:58.434693807Z Migrating to CreateComments (20241007182824)
2025-10-09T14:27:58.434701824Z == 20241007182824 CreateComments: migrating ===================================
2025-10-09T14:27:58.434710000Z -- create_table(:comments)
2025-10-09T14:27:58.434718307Z    -> 0.0022s
2025-10-09T14:27:58.434726333Z == 20241007182824 CreateComments: migrated (0.0022s) ==========================
2025-10-09T14:27:58.434734700Z 
2025-10-09T14:27:58.434742806Z Migrating to AddSystemToComments (20241009122540)
2025-10-09T14:27:58.434762436Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-10-09T14:27:58.434770542Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-10-09T14:27:58.434778718Z    -> 0.0009s
2025-10-09T14:27:58.434786554Z == 20241009122540 AddSystemToComments: migrated (0.0009s) =====================
2025-10-09T14:27:58.434795853Z 
2025-10-09T14:27:58.434805903Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-10-09T14:27:58.434816404Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-10-09T14:27:58.434826124Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0017s) ============
2025-10-09T14:27:58.434834400Z 
2025-10-09T14:27:58.434842116Z Migrating to AddOmniauthToUsers (20241015090803)
2025-10-09T14:27:58.434850192Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-10-09T14:27:58.434858289Z -- add_column(:users, :auth_provider, :string)
2025-10-09T14:27:58.434866225Z    -> 0.0008s
2025-10-09T14:27:58.434874151Z -- add_column(:users, :auth_uid, :string)
2025-10-09T14:27:58.434882798Z    -> 0.0007s
2025-10-09T14:27:58.434890764Z == 20241015090803 AddOmniauthToUsers: migrated (0.0016s) ======================
2025-10-09T14:27:58.434898770Z 
2025-10-09T14:27:58.434906486Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-10-09T14:27:58.434914492Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-10-09T14:27:58.434922728Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-10-09T14:27:58.434931376Z    -> 0.0008s
2025-10-09T14:27:58.434939191Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-10-09T14:27:58.434947398Z    -> 0.0008s
2025-10-09T14:27:58.434955254Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0017s) =====
2025-10-09T14:27:58.434963280Z 
2025-10-09T14:27:58.434971016Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-10-09T14:27:58.434978982Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-10-09T14:27:58.434986968Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-10-09T14:27:58.434994974Z    -> 0.0008s
2025-10-09T14:27:58.435004082Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-10-09T14:27:58.435014323Z 
2025-10-09T14:27:58.435023652Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-10-09T14:27:58.435033481Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-10-09T14:27:58.435041608Z -- change_table(:users)
2025-10-09T14:27:58.435059844Z    -> 0.0010s
2025-10-09T14:27:58.435067971Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-10-09T14:27:58.435076909Z 
2025-10-09T14:27:58.435086849Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-10-09T14:27:58.435096999Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-10-09T14:27:58.435107751Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0042s) =================
2025-10-09T14:27:58.435118002Z 
2025-10-09T14:27:58.435127942Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-10-09T14:27:58.435138172Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-10-09T14:27:58.435148713Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-10-09T14:27:58.435158393Z    -> 0.0009s
2025-10-09T14:27:58.435166269Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-10-09T14:27:58.435174996Z    -> 0.0013s
2025-10-09T14:27:58.435182932Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-10-09T14:27:58.435191069Z    -> 0.0005s
2025-10-09T14:27:58.435198844Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-10-09T14:27:58.435206991Z    -> 0.0010s
2025-10-09T14:27:58.435214786Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-10-09T14:27:58.435224456Z    -> 0.0008s
2025-10-09T14:27:58.435234767Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-10-09T14:27:58.435245588Z    -> 0.0008s
2025-10-09T14:27:58.435256711Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-10-09T14:27:58.435267643Z    -> 0.0004s
2025-10-09T14:27:58.435277863Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0059s) ===================
2025-10-09T14:27:58.435288114Z 
2025-10-09T14:27:58.435298074Z Migrating to AddInProgressToProblems (20241105121830)
2025-10-09T14:27:58.435306661Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-10-09T14:27:58.435314838Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-10-09T14:27:58.435323125Z    -> 0.0009s
2025-10-09T14:27:58.435330970Z == 20241105121830 AddInProgressToProblems: migrated (0.0009s) =================
2025-10-09T14:27:58.435339027Z 
2025-10-09T14:27:58.435346732Z Migrating to ClearStuckProblems (20241118155027)
2025-10-09T14:27:58.435356111Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-10-09T14:27:58.435380901Z == 20241118155027 ClearStuckProblems: migrated (0.0199s) ======================
2025-10-09T14:27:58.435391101Z 
2025-10-09T14:27:58.435400601Z Migrating to AddApprovedToUser (20241122121621)
2025-10-09T14:27:58.435410821Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-10-09T14:27:58.435420721Z -- change_table(:users)
2025-10-09T14:27:58.435428948Z    -> 0.0016s
2025-10-09T14:27:58.435438737Z == 20241122121621 AddApprovedToUser: migrated (0.0017s) =======================
2025-10-09T14:27:58.435448477Z 
2025-10-09T14:27:58.435458237Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-10-09T14:27:58.435467405Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-10-09T14:27:58.435475481Z -- create_table(:federails_moderation_reports)
2025-10-09T14:27:58.435483678Z    -> 0.0032s
2025-10-09T14:27:58.435491604Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0033s) ========
2025-10-09T14:27:58.435499780Z 
2025-10-09T14:27:58.435507496Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-10-09T14:27:58.435515712Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-10-09T14:27:58.435523739Z -- create_table(:federails_moderation_domain_blocks)
2025-10-09T14:27:58.435532075Z    -> 0.0006s
2025-10-09T14:27:58.435539931Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0006s) ===
2025-10-09T14:27:58.435548048Z 
2025-10-09T14:27:58.435555783Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-10-09T14:27:58.435563759Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-10-09T14:27:58.435571765Z -- change_column_null(:comments, :commenter_id, true)
2025-10-09T14:27:58.435579741Z    -> 0.0088s
2025-10-09T14:27:58.435587587Z -- change_column_null(:comments, :commenter_type, true)
2025-10-09T14:27:58.435595553Z    -> 0.0084s
2025-10-09T14:27:58.435603399Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-10-09T14:27:58.435611766Z    -> 0.0009s
2025-10-09T14:27:58.435620584Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-10-09T14:27:58.435630353Z    -> 0.0128s
2025-10-09T14:27:59.240038841Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0333s) =======
2025-10-09T14:27:59.240086357Z 
2025-10-09T14:27:59.240095475Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-10-09T14:27:59.240103782Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-10-09T14:27:59.240112399Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-10-09T14:27:59.240144504Z    -> 0.0010s
2025-10-09T14:27:59.240153402Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0010s) =================
2025-10-09T14:27:59.240161528Z 
2025-10-09T14:27:59.240169524Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-10-09T14:27:59.240177530Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-10-09T14:27:59.240185677Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1354s) ==================
2025-10-09T14:27:59.240193753Z 
2025-10-09T14:27:59.240201709Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-10-09T14:27:59.240209665Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-10-09T14:27:59.240217641Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-10-09T14:27:59.240225717Z    -> 0.0019s
2025-10-09T14:27:59.240233663Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0020s) ==========
2025-10-09T14:27:59.240241679Z 
2025-10-09T14:27:59.240249435Z Migrating to AddCreatorToCollections (20250222000000)
2025-10-09T14:27:59.240259686Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-10-09T14:27:59.240267802Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-10-09T14:27:59.240275958Z    -> 0.0260s
2025-10-09T14:27:59.240283814Z == 20250222000000 AddCreatorToCollections: migrated (0.0261s) =================
2025-10-09T14:27:59.240291850Z 
2025-10-09T14:27:59.240299626Z Migrating to AddLocalToActors (20250305171530)
2025-10-09T14:27:59.240307933Z == 20250305171530 AddLocalToActors: migrating =================================
2025-10-09T14:27:59.240315929Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-10-09T14:27:59.240324015Z    -> 0.0009s
2025-10-09T14:27:59.240331911Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-10-09T14:27:59.240340358Z    -> 0.0020s
2025-10-09T14:27:59.240348474Z    -> 0 rows
2025-10-09T14:27:59.240356380Z == 20250305171530 AddLocalToActors: migrated (0.0061s) ========================
2025-10-09T14:27:59.240364497Z 
2025-10-09T14:27:59.240372252Z Migrating to AddActorTypeToActors (20250407160721)
2025-10-09T14:27:59.240380168Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-10-09T14:27:59.240388164Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-10-09T14:27:59.240396201Z    -> 0.0008s
2025-10-09T14:27:59.240404036Z == 20250407160721 AddActorTypeToActors: migrated (0.0009s) ====================
2025-10-09T14:27:59.240412083Z 
2025-10-09T14:27:59.240429888Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-10-09T14:27:59.240437915Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-10-09T14:27:59.240447394Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-10-09T14:27:59.240455540Z    -> 0.0013s
2025-10-09T14:27:59.240463486Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0014s) =================
2025-10-09T14:27:59.240471582Z 
2025-10-09T14:27:59.240479308Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-10-09T14:27:59.240487364Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-10-09T14:27:59.240495370Z -- create_table(:oauth_applications)
2025-10-09T14:27:59.240503406Z    -> 0.0004s
2025-10-09T14:27:59.240511262Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-10-09T14:27:59.240519268Z    -> 0.0002s
2025-10-09T14:27:59.240527244Z -- create_table(:oauth_access_grants)
2025-10-09T14:27:59.240535130Z    -> 0.0006s
2025-10-09T14:27:59.240542996Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-10-09T14:27:59.240550982Z    -> 0.0001s
2025-10-09T14:27:59.240558838Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-10-09T14:27:59.240566964Z    -> 0.0076s
2025-10-09T14:27:59.240574820Z -- create_table(:oauth_access_tokens)
2025-10-09T14:27:59.240582696Z    -> 0.0006s
2025-10-09T14:27:59.240590492Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-10-09T14:27:59.240598518Z    -> 0.0001s
2025-10-09T14:27:59.240606414Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-10-09T14:27:59.240614430Z    -> 0.0001s
2025-10-09T14:27:59.240622356Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-10-09T14:27:59.240630472Z    -> 0.0092s
2025-10-09T14:27:59.240638278Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-10-09T14:27:59.240646294Z    -> 0.0102s
2025-10-09T14:27:59.240654130Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-10-09T14:27:59.240663108Z    -> 0.0089s
2025-10-09T14:27:59.240670934Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0383s) ==================
2025-10-09T14:27:59.240678960Z 
2025-10-09T14:27:59.240686685Z Migrating to AddOwnerToApplication (20250408145956)
2025-10-09T14:27:59.240694581Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-10-09T14:27:59.240702658Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-10-09T14:27:59.240720013Z    -> 0.0009s
2025-10-09T14:27:59.240727929Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-10-09T14:27:59.240736005Z    -> 0.0008s
2025-10-09T14:27:59.240743851Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-10-09T14:27:59.240751877Z    -> 0.0004s
2025-10-09T14:27:59.240759733Z == 20250408145956 AddOwnerToApplication: migrated (0.0073s) ===================
2025-10-09T14:27:59.240767789Z 
2025-10-09T14:27:59.240775544Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-10-09T14:27:59.240783520Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-10-09T14:27:59.240791557Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-10-09T14:27:59.240799623Z    -> 0.0098s
2025-10-09T14:27:59.240807429Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0112s) ============
2025-10-09T14:27:59.240815435Z 
2025-10-09T14:27:59.240823150Z Migrating to AddQuotaToUsers (20250409125753)
2025-10-09T14:27:59.240831517Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-10-09T14:27:59.240839583Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-10-09T14:27:59.240847569Z    -> 0.0010s
2025-10-09T14:27:59.240855385Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-10-09T14:27:59.240863512Z    -> 0.0008s
2025-10-09T14:27:59.240871327Z == 20250409125753 AddQuotaToUsers: migrated (0.0032s) =========================
2025-10-09T14:27:59.240879434Z 
2025-10-09T14:27:59.240887089Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-10-09T14:27:59.240895135Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-10-09T14:27:59.240903181Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-10-09T14:27:59.240911558Z    -> 0.0117s
2025-10-09T14:27:59.240919474Z -- add_index(:model_files, :filename_lower)
2025-10-09T14:27:59.240927480Z    -> 0.0002s
2025-10-09T14:27:59.240935316Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0133s) 
2025-10-09T14:27:59.240943382Z 
2025-10-09T14:27:59.240951058Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-10-09T14:27:59.240958964Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-10-09T14:27:59.240966980Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-10-09T14:27:59.240974976Z    -> 0.0002s
2025-10-09T14:27:59.240982802Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-10-09T14:27:59.240990898Z 
2025-10-09T14:27:59.241007802Z Migrating to AddPreviewToModelFile (20250520111046)
2025-10-09T14:27:59.241015858Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-10-09T14:27:59.241023824Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-10-09T14:27:59.241031911Z    -> 0.0010s
2025-10-09T14:27:59.241039696Z == 20250520111046 AddPreviewToModelFile: migrated (0.0018s) ===================
2025-10-09T14:27:59.241047813Z 
2025-10-09T14:27:59.241055528Z Migrating to CreateAltchaSolutions (20250609210440)
2025-10-09T14:27:59.241063544Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-10-09T14:27:59.241071570Z -- create_table(:altcha_solutions)
2025-10-09T14:27:59.241079456Z    -> 0.0004s
2025-10-09T14:27:59.241087352Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-10-09T14:27:59.241095919Z    -> 0.0002s
2025-10-09T14:27:59.241103775Z == 20250609210440 CreateAltchaSolutions: migrated (0.0016s) ===================
2025-10-09T14:27:59.241111811Z 
2025-10-09T14:27:59.241119567Z Migrating to AddIndexableFields (20250620141805)
2025-10-09T14:27:59.241127523Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-10-09T14:27:59.241135499Z -- change_table(:models)
2025-10-09T14:27:59.241143365Z    -> 0.0026s
2025-10-09T14:27:59.241151201Z -- change_table(:creators)
2025-10-09T14:27:59.241159077Z    -> 0.0018s
2025-10-09T14:27:59.241166872Z -- change_table(:collections)
2025-10-09T14:27:59.241174738Z    -> 0.0017s
2025-10-09T14:27:59.241182564Z == 20250620141805 AddIndexableFields: migrated (0.0061s) ======================
2025-10-09T14:27:59.241190700Z 
2025-10-09T14:27:59.241199127Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-10-09T14:27:59.241207163Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-10-09T14:27:59.241215150Z -- change_column(:models, :indexable, :string)
2025-10-09T14:27:59.241223096Z    -> 0.0370s
2025-10-09T14:27:59.241230911Z -- change_column(:models, :ai_indexable, :string)
2025-10-09T14:27:59.241238847Z    -> 0.0209s
2025-10-09T14:27:59.241247535Z -- change_column(:creators, :indexable, :string)
2025-10-09T14:27:59.241255541Z    -> 0.0102s
2025-10-09T14:27:59.241263417Z -- change_column(:creators, :ai_indexable, :string)
2025-10-09T14:27:59.241271333Z    -> 0.0098s
2025-10-09T14:27:59.241279198Z -- change_column(:collections, :indexable, :string)
2025-10-09T14:27:59.241287175Z    -> 0.0540s
2025-10-09T14:27:59.241304179Z -- change_column(:collections, :ai_indexable, :string)
2025-10-09T14:27:59.241312215Z    -> 0.0142s
2025-10-09T14:27:59.241320021Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1466s) ======
2025-10-09T14:27:59.241328087Z 
2025-10-09T14:27:59.241335762Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-10-09T14:27:59.241343688Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-10-09T14:27:59.241351654Z -- change_table(:models)
2025-10-09T14:27:59.241359440Z    -> 0.0004s
2025-10-09T14:27:59.241367266Z -- change_table(:creators)
2025-10-09T14:27:59.241375082Z    -> 0.0003s
2025-10-09T14:27:59.241382867Z -- change_table(:collections)
2025-10-09T14:27:59.241390753Z    -> 0.0003s
2025-10-09T14:27:59.241398559Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0009s) =================
2025-10-09T14:27:59.241406525Z 
2025-10-09T14:27:59.241414190Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-10-09T14:27:59.241422156Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-10-09T14:27:59.241430273Z -- change_table(:links)
2025-10-09T14:27:59.241438118Z    -> 0.0002s
2025-10-09T14:27:59.241446004Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-10-09T14:27:59.241454051Z 
2025-10-09T14:27:59.241461736Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-10-09T14:27:59.241469682Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-10-09T14:27:59.241477678Z -- add_column(:links, :synced_at, :datetime)
2025-10-09T14:27:59.241485594Z    -> 0.0010s
2025-10-09T14:27:59.241493440Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0011s) ======================
2025-10-09T14:27:59.241501456Z 
2025-10-09T14:27:59.241509152Z Migrating to CreateFaspClientProviders (20250806142734)
2025-10-09T14:27:59.241517208Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-10-09T14:27:59.241525184Z -- create_table(:fasp_client_providers)
2025-10-09T14:27:59.241533060Z    -> 0.0465s
2025-10-09T14:27:59.241540895Z == 20250806142734 CreateFaspClientProviders: migrated (0.0465s) ===============
2025-10-09T14:27:59.241548922Z 
2025-10-09T14:27:59.241556557Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-10-09T14:27:59.241564513Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-10-09T14:27:59.241572519Z -- create_table(:fasp_client_event_subscriptions)
2025-10-09T14:27:59.241580445Z    -> 0.0146s
2025-10-09T14:27:59.241597319Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0146s) ======
2025-10-09T14:27:59.241605415Z 
2025-10-09T14:27:59.241613602Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-10-09T14:27:59.272933559Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-10-09T14:27:59.272958809Z -- create_table(:fasp_client_backfill_requests)
2025-10-09T14:27:59.272968168Z    -> 0.0055s
2025-10-09T14:27:59.272977958Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0055s) ========
2025-10-09T14:27:59.272988098Z 
2025-10-09T14:27:59.272997968Z Migrating to AddImagesToCreators (20250922155445)
2025-10-09T14:27:59.273007317Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-10-09T14:27:59.273015313Z -- add_column(:creators, :avatar_data, :json)
2025-10-09T14:27:59.273023189Z    -> 0.0010s
2025-10-09T14:27:59.273031025Z -- add_column(:creators, :banner_data, :json)
2025-10-09T14:27:59.273039111Z    -> 0.0009s
2025-10-09T14:27:59.273047087Z == 20250922155445 AddImagesToCreators: migrated (0.0020s) =====================
2025-10-09T14:27:59.273055113Z 
2025-10-09T14:27:59.334931199Z s6-rc: info: service init-manyfold-config successfully started
2025-10-09T14:27:59.335186493Z s6-rc: info: service init-config-end: starting
2025-10-09T14:27:59.337577217Z s6-rc: info: service init-config-end successfully started
2025-10-09T14:27:59.337741447Z s6-rc: info: service init-mods: starting
2025-10-09T14:27:59.339349164Z s6-rc: info: service init-mods successfully started
2025-10-09T14:27:59.339467913Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-10-09T14:27:59.348337163Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-10-09T14:27:59.348584200Z s6-rc: info: service init-mods-package-install: starting
2025-10-09T14:27:59.360563623Z [pkg-install-init] **** Installing all mod packages ****
2025-10-09T14:27:59.367792639Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-10-09T14:27:59.471491249Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-10-09T14:27:59.798749735Z (1/1) Installing redis (8.0.4-r0)
2025-10-09T14:27:59.808801416Z Executing redis-8.0.4-r0.pre-install
2025-10-09T14:27:59.851340534Z Executing redis-8.0.4-r0.post-install
2025-10-09T14:27:59.860673908Z Executing busybox-1.37.0-r19.trigger
2025-10-09T14:27:59.872598108Z OK: 428 MiB in 119 packages
2025-10-09T14:27:59.977682439Z s6-rc: info: service init-mods-package-install successfully started
2025-10-09T14:27:59.977976521Z s6-rc: info: service init-mods-end: starting
2025-10-09T14:27:59.980037531Z s6-rc: info: service init-mods-end successfully started
2025-10-09T14:27:59.980290511Z s6-rc: info: service init-custom-files: starting
2025-10-09T14:27:59.987352190Z [custom-init] No custom files found, skipping...
2025-10-09T14:27:59.988032500Z s6-rc: info: service init-custom-files successfully started
2025-10-09T14:27:59.988283085Z s6-rc: info: service init-services: starting
2025-10-09T14:27:59.989869790Z s6-rc: info: service init-services successfully started
2025-10-09T14:27:59.990081987Z s6-rc: info: service svc-mod-universal-redis: starting
2025-10-09T14:27:59.990263322Z s6-rc: info: service svc-manyfold: starting
2025-10-09T14:27:59.990431771Z s6-rc: info: service svc-cron: starting
2025-10-09T14:27:59.993377593Z s6-rc: info: service svc-cron successfully started
2025-10-09T14:27:59.994061250Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-10-09T14:28:00.008406696Z 283:C 09 Oct 2025 14:28:00.008 # 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-09T14:28:00.008448240Z 283:C 09 Oct 2025 14:28:00.008 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-10-09T14:28:00.008456466Z 283:C 09 Oct 2025 14:28:00.008 * Redis version=8.0.4, bits=64, commit=00000000, modified=1, pid=283, just started
2025-10-09T14:28:00.008466426Z 283:C 09 Oct 2025 14:28:00.008 # 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-09T14:28:00.009580760Z 283:M 09 Oct 2025 14:28:00.009 * monotonic clock: POSIX clock_gettime
2025-10-09T14:28:00.010293114Z 283:M 09 Oct 2025 14:28:00.010 * Running mode=standalone, port=6379.
2025-10-09T14:28:00.010787931Z 283:M 09 Oct 2025 14:28:00.010 * Server initialized
2025-10-09T14:28:00.010829434Z 283:M 09 Oct 2025 14:28:00.010 * Ready to accept connections tcp
2025-10-09T14:28:00.155095312Z 14:28:00 rails.1              | started with pid 301
2025-10-09T14:28:00.155127076Z 14:28:00 default_worker.1     | started with pid 302
2025-10-09T14:28:00.155136445Z 14:28:00 performance_worker.1 | started with pid 303
2025-10-09T14:28:01.425287974Z 14:28:01 rails.1              | `/root` is not writable.
2025-10-09T14:28:01.425325350Z 14:28:01 rails.1              | Bundler will use `/tmp/bundler20251009-301-8lm6oz301' as your home directory temporarily.
2025-10-09T14:28:01.888758070Z 14:28:01 performance_worker.1 | `/root` is not writable.
2025-10-09T14:28:01.888793441Z 14:28:01 performance_worker.1 | Bundler will use `/tmp/bundler20251009-303-chc7k303' as your home directory temporarily.
2025-10-09T14:28:01.915774380Z 14:28:01 default_worker.1     | `/root` is not writable.
2025-10-09T14:28:01.915811205Z 14:28:01 default_worker.1     | Bundler will use `/tmp/bundler20251009-302-5z3zyz302' as your home directory temporarily.
2025-10-09T14:28:02.848635975Z 14:28:02 rails.1              | => Booting Puma
2025-10-09T14:28:02.848681807Z 14:28:02 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-10-09T14:28:02.848702519Z 14:28:02 rails.1              | => Run `bin/rails server --help` for more startup options
2025-10-09T14:28:03.388534118Z 14:28:03 performance_worker.1 | Server: 96304c261f62, Context: rails, Role: web, data: {cpu: {one_min: 5.23, five_min: 2.75, fifteen_min: 2.25}, memory: 0.191397888e9, disk: {available: 828507811840, total: 938656133120, used: 110148321280}}
2025-10-09T14:28:03.396730281Z 14:28:03 default_worker.1     | Server: 96304c261f62, Context: rails, Role: web, data: {cpu: {one_min: 5.23, five_min: 2.75, fifteen_min: 2.25}, memory: 0.191647744e9, disk: {available: 828507754496, total: 938656133120, used: 110148378624}}
2025-10-09T14:28:05.609170268Z 14:28:05 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:05.609831820Z 14:28:05 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:05.610911965Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.610Z pid=302 tid=246: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-09T14:28:05.611572756Z 14:28:05 performance_worker.1 | INFO  2025-10-09T14:28:05.611Z pid=303 tid=247: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-09T14:28:05.616600950Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.616Z pid=302 tid=246: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-09T14:28:05.616610830Z 14:28:05 performance_worker.1 | INFO  2025-10-09T14:28:05.616Z pid=303 tid=247: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-09T14:28:05.680790715Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.680Z pid=302 tid=246: Booted Rails 8.0.2.1 application in production environment
2025-10-09T14:28:05.680802007Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.680Z pid=302 tid=246: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-09T14:28:05.680807188Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.680Z pid=302 tid=246: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-09T14:28:05.680830164Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.680Z pid=302 tid=246: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-09T14:28:05.683390339Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.683Z pid=302 tid=246: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-10-09T14:28:05.686344117Z 14:28:05 performance_worker.1 | INFO  2025-10-09T14:28:05.685Z pid=303 tid=247: Booted Rails 8.0.2.1 application in production environment
2025-10-09T14:28:05.686370921Z 14:28:05 performance_worker.1 | INFO  2025-10-09T14:28:05.686Z pid=303 tid=247: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-09T14:28:05.686448046Z 14:28:05 performance_worker.1 | INFO  2025-10-09T14:28:05.686Z pid=303 tid=247: See LICENSE and the LGPL-3.0 for licensing details.
2025-10-09T14:28:05.686477606Z 14:28:05 performance_worker.1 | INFO  2025-10-09T14:28:05.686Z pid=303 tid=247: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-10-09T14:28:05.689088353Z 14:28:05 performance_worker.1 | INFO  2025-10-09T14:28:05.688Z pid=303 tid=247: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-10-09T14:28:05.783633562Z 14:28:05 rails.1              | Server: 96304c261f62, Context: rails, Role: web, data: {cpu: {one_min: 5.23, five_min: 2.75, fifteen_min: 2.25}, memory: 0.177164288e9, disk: {available: 828508590080, total: 938656133120, used: 110147543040}}
2025-10-09T14:28:05.783662811Z 14:28:05 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:05.783666859Z 14:28:05 rails.1              | INFO  2025-10-09T14:28:05.611Z pid=301 tid=205: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-10-09T14:28:05.783671548Z 14:28:05 rails.1              | INFO  2025-10-09T14:28:05.616Z pid=301 tid=205: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-10-09T14:28:05.783680516Z 14:28:05 rails.1              | INFO  2025-10-09T14:28:05.618Z pid=301 tid=205: Cron Jobs - added job with name clear-downloads in the namespace default
2025-10-09T14:28:05.783687601Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: e70b5580-91d1-4a01-8c33-1e71007e6f3c) 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-09T14:28:05.783712230Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 9eb119dc-5003-4371-87b3-599e76b219db) 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-09T14:28:05.783738643Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1) 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-09T14:28:05.783769055Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: f0fba1c6-ec8c-40ef-906a-1187ef6c02f6) to Sidekiq(upgrade)
2025-10-09T14:28:05.787532683Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: b46a48aa-f8ff-4430-8342-d89f2f629d68) to Sidekiq(upgrade)
2025-10-09T14:28:05.787544015Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 28e46989-ffb5-4e81-87e2-6f5b199963b1) to Sidekiq(upgrade)
2025-10-09T14:28:05.787582683Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 0074c692-2d6d-4b90-a20d-e969f35f3fbd) to Sidekiq(upgrade)
2025-10-09T14:28:05.787587563Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 213383b7-2eb8-4085-86bf-201c9fe66814) to Sidekiq(upgrade)
2025-10-09T14:28:05.787592583Z 14:28:05 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: 6d538e9e-b550-462d-b147-75beac7be6da) to Sidekiq(upgrade)
2025-10-09T14:28:05.787604798Z 14:28:05 rails.1              | [301] Puma starting in cluster mode...
2025-10-09T14:28:05.787635860Z 14:28:05 rails.1              | [301] * Puma version: 7.0.4 ("Romantic Warrior")
2025-10-09T14:28:05.787647023Z 14:28:05 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-10-09T14:28:05.787679148Z 14:28:05 rails.1              | [301] *  Min threads: 4
2025-10-09T14:28:05.787686452Z 14:28:05 rails.1              | [301] *  Max threads: 16
2025-10-09T14:28:05.787720932Z 14:28:05 rails.1              | [301] *  Environment: production
2025-10-09T14:28:05.787728627Z 14:28:05 rails.1              | [301] *   Master PID: 301
2025-10-09T14:28:05.787777726Z 14:28:05 rails.1              | [301] *      Workers: 4
2025-10-09T14:28:05.787807055Z 14:28:05 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-10-09T14:28:05.787816654Z 14:28:05 rails.1              | [301] * Preloading application
2025-10-09T14:28:05.787824590Z 14:28:05 rails.1              | [301] * Listening on http://[::]:3214
2025-10-09T14:28:05.787853288Z 14:28:05 rails.1              | [301] Use Ctrl-C to stop
2025-10-09T14:28:05.810014493Z 14:28:05 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-10-09T14:28:05.810097400Z 14:28:05 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.01s, phase: 0
2025-10-09T14:28:05.810160327Z 14:28:05 rails.1              | [301] - Worker 2 (PID: 402) booted in 0.01s, phase: 0
2025-10-09T14:28:05.811755308Z 14:28:05 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-10-09T14:28:05.939380187Z 14:28:05 performance_worker.1 | Server: 96304c261f62, Context: sidekiq, Role: background, data: {cpu: {one_min: 5.53, five_min: 2.86, fifteen_min: 2.29}, memory: 0.23097344e9, disk: {available: 828499615744, total: 938656133120, used: 110156517376}}
2025-10-09T14:28:05.939991378Z 14:28:05 default_worker.1     | Server: 96304c261f62, Context: sidekiq, Role: background, data: {cpu: {one_min: 5.53, five_min: 2.86, fifteen_min: 2.29}, memory: 0.230961152e9, disk: {available: 828499615744, total: 938656133120, used: 110156517376}}
2025-10-09T14:28:05.995314728Z 14:28:05 default_worker.1     | INFO  2025-10-09T14:28:05.940Z pid=302 tid=ho6 jid=5a92cbb6c8530ba5b4a139b0 class=Upgrade::GenerateSlugsJob: start
2025-10-09T14:28:06.002736523Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e70b5580-91d1-4a01-8c33-1e71007e6f3c] Performing Upgrade::GenerateSlugsJob (Job ID: e70b5580-91d1-4a01-8c33-1e71007e6f3c) from Sidekiq(high) enqueued at 2025-10-09T14:28:05.630375487Z 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-09T14:28:06.008318653Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:05.988Z pid=302 tid=hn2 jid=32c208a64cf4fd5cfd3a6eff class=Upgrade::GenerateSlugsJob: start
2025-10-09T14:28:06.028034273Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-10-09T14:28:06.029254801Z s6-rc: info: service svc-manyfold successfully started
2025-10-09T14:28:06.029452459Z s6-rc: info: service legacy-services: starting
2025-10-09T14:28:06.033126988Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [9eb119dc-5003-4371-87b3-599e76b219db] Performing Upgrade::GenerateSlugsJob (Job ID: 9eb119dc-5003-4371-87b3-599e76b219db) from Sidekiq(high) enqueued at 2025-10-09T14:28:05.633285817Z 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-09T14:28:06.039431964Z s6-rc: info: service legacy-services successfully started
2025-10-09T14:28:06.039585984Z s6-rc: info: service ci-service-check: starting
2025-10-09T14:28:06.042639032Z [ls.io-init] done.
2025-10-09T14:28:06.043116052Z s6-rc: info: service ci-service-check successfully started
2025-10-09T14:28:06.050951230Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:05.994Z pid=302 tid=hmu jid=b840a236383e07f0d7068cfe class=Upgrade::GenerateSlugsJob: start
2025-10-09T14:28:06.092382085Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1] Performing Upgrade::GenerateSlugsJob (Job ID: ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1) from Sidekiq(high) enqueued at 2025-10-09T14:28:05.635074168Z 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-09T14:28:06.093684648Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:05.995Z pid=302 tid=hni jid=c150ea603233a97be093cbef class=Upgrade::FixNilFileSizeValues: start
2025-10-09T14:28:06.094521433Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f0fba1c6-ec8c-40ef-906a-1187ef6c02f6] Performing Upgrade::FixNilFileSizeValues (Job ID: f0fba1c6-ec8c-40ef-906a-1187ef6c02f6) from Sidekiq(upgrade) enqueued at 2025-10-09T14:28:05.636889985Z
2025-10-09T14:28:06.103149517Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:06.104515117Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [9eb119dc-5003-4371-87b3-599e76b219db] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:06.129591421Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f0fba1c6-ec8c-40ef-906a-1187ef6c02f6] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:06.146149213Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-09T14:28:06.221523578Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.063
2025-10-09T14:28:06.375452013Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [9eb119dc-5003-4371-87b3-599e76b219db] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-09T14:28:06.409403879Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [9eb119dc-5003-4371-87b3-599e76b219db] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.258
2025-10-09T14:28:06.421915823Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f0fba1c6-ec8c-40ef-906a-1187ef6c02f6] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-09T14:28:06.428409409Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f0fba1c6-ec8c-40ef-906a-1187ef6c02f6] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.196
2025-10-09T14:28:06.443444765Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e70b5580-91d1-4a01-8c33-1e71007e6f3c] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:06.533441294Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e70b5580-91d1-4a01-8c33-1e71007e6f3c] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-09T14:28:06.534160823Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e70b5580-91d1-4a01-8c33-1e71007e6f3c] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.085
2025-10-09T14:28:06.580055938Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1] Performed Upgrade::GenerateSlugsJob (Job ID: ac993ad0-6d89-4fcc-a799-cd9e2b7dafe1) from Sidekiq(high) in 506.21ms
2025-10-09T14:28:06.586906914Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [9eb119dc-5003-4371-87b3-599e76b219db] Performed Upgrade::GenerateSlugsJob (Job ID: 9eb119dc-5003-4371-87b3-599e76b219db) from Sidekiq(high) in 575.83ms
2025-10-09T14:28:06.590864493Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.587Z pid=302 tid=hmu jid=b840a236383e07f0d7068cfe class=Upgrade::GenerateSlugsJob elapsed=0.592: done
2025-10-09T14:28:06.592750891Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.592Z pid=302 tid=hn2 jid=32c208a64cf4fd5cfd3a6eff class=Upgrade::GenerateSlugsJob elapsed=0.604: done
2025-10-09T14:28:06.593115756Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f0fba1c6-ec8c-40ef-906a-1187ef6c02f6] Performed Upgrade::FixNilFileSizeValues (Job ID: f0fba1c6-ec8c-40ef-906a-1187ef6c02f6) from Sidekiq(upgrade) in 497.72ms
2025-10-09T14:28:06.593336600Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.592Z pid=302 tid=hmu jid=70afa2ba05392566de5bb1b7 class=Upgrade::BackfillDataPackages: start
2025-10-09T14:28:06.596188323Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.596Z pid=302 tid=hni jid=c150ea603233a97be093cbef class=Upgrade::FixNilFileSizeValues elapsed=0.601: done
2025-10-09T14:28:06.596378095Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [e70b5580-91d1-4a01-8c33-1e71007e6f3c] Performed Upgrade::GenerateSlugsJob (Job ID: e70b5580-91d1-4a01-8c33-1e71007e6f3c) from Sidekiq(high) in 596.37ms
2025-10-09T14:28:06.596570352Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.593Z pid=302 tid=hn2 jid=cf8ad8c0b79ac4ec6e147ed7 class=Upgrade::DisambiguateUsernamesJob: start
2025-10-09T14:28:06.602870558Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.602Z pid=302 tid=ho6 jid=5a92cbb6c8530ba5b4a139b0 class=Upgrade::GenerateSlugsJob elapsed=0.662: done
2025-10-09T14:28:06.603077345Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [b46a48aa-f8ff-4430-8342-d89f2f629d68] Performing Upgrade::BackfillDataPackages (Job ID: b46a48aa-f8ff-4430-8342-d89f2f629d68) from Sidekiq(upgrade) enqueued at 2025-10-09T14:28:05.637596758Z
2025-10-09T14:28:06.604750374Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.596Z pid=302 tid=hni jid=c504a09c083f7138b4b05504 class=Upgrade::UpdateActorsJob: start
2025-10-09T14:28:06.605530444Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [28e46989-ffb5-4e81-87e2-6f5b199963b1] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 28e46989-ffb5-4e81-87e2-6f5b199963b1) from Sidekiq(upgrade) enqueued at 2025-10-09T14:28:05.638267148Z
2025-10-09T14:28:06.605906912Z 14:28:06 default_worker.1     | INFO  2025-10-09T14:28:06.603Z pid=302 tid=ho6 jid=30c0629f7f698aca76d515ad class=Upgrade::FixParentCollections: start
2025-10-09T14:28:06.607095506Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [0074c692-2d6d-4b90-a20d-e969f35f3fbd] Performing Upgrade::UpdateActorsJob (Job ID: 0074c692-2d6d-4b90-a20d-e969f35f3fbd) from Sidekiq(upgrade) enqueued at 2025-10-09T14:28:05.638915654Z
2025-10-09T14:28:06.612851196Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [213383b7-2eb8-4085-86bf-201c9fe66814] Performing Upgrade::FixParentCollections (Job ID: 213383b7-2eb8-4085-86bf-201c9fe66814) from Sidekiq(upgrade) enqueued at 2025-10-09T14:28:05.639561514Z
2025-10-09T14:28:06.649897603Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [b46a48aa-f8ff-4430-8342-d89f2f629d68] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:06.739439387Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [28e46989-ffb5-4e81-87e2-6f5b199963b1] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:06.816303332Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [0074c692-2d6d-4b90-a20d-e969f35f3fbd] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:06.926817727Z 14:28:06 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [213383b7-2eb8-4085-86bf-201c9fe66814] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:07.087694853Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [b46a48aa-f8ff-4430-8342-d89f2f629d68] Performed Upgrade::BackfillDataPackages (Job ID: b46a48aa-f8ff-4430-8342-d89f2f629d68) from Sidekiq(upgrade) in 493.36ms
2025-10-09T14:28:07.092179804Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [0074c692-2d6d-4b90-a20d-e969f35f3fbd] Performed Upgrade::UpdateActorsJob (Job ID: 0074c692-2d6d-4b90-a20d-e969f35f3fbd) from Sidekiq(upgrade) in 486.94ms
2025-10-09T14:28:07.113095721Z 14:28:07 default_worker.1     | INFO  2025-10-09T14:28:07.101Z pid=302 tid=hmu jid=70afa2ba05392566de5bb1b7 class=Upgrade::BackfillDataPackages elapsed=0.508: done
2025-10-09T14:28:07.113445616Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [213383b7-2eb8-4085-86bf-201c9fe66814] Performed Upgrade::FixParentCollections (Job ID: 213383b7-2eb8-4085-86bf-201c9fe66814) from Sidekiq(upgrade) in 506.41ms
2025-10-09T14:28:07.113995042Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [28e46989-ffb5-4e81-87e2-6f5b199963b1] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 28e46989-ffb5-4e81-87e2-6f5b199963b1) from Sidekiq(upgrade) in 516.8ms
2025-10-09T14:28:07.132028655Z 14:28:07 default_worker.1     | INFO  2025-10-09T14:28:07.112Z pid=302 tid=hni jid=c504a09c083f7138b4b05504 class=Upgrade::UpdateActorsJob elapsed=0.516: done
2025-10-09T14:28:07.132150350Z 14:28:07 default_worker.1     | INFO  2025-10-09T14:28:07.113Z pid=302 tid=hmu jid=1a89013d92583c66f39212ad class=Upgrade::PruneOrphanedProblems: start
2025-10-09T14:28:07.148608681Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [6d538e9e-b550-462d-b147-75beac7be6da] Performing Upgrade::PruneOrphanedProblems (Job ID: 6d538e9e-b550-462d-b147-75beac7be6da) from Sidekiq(upgrade) enqueued at 2025-10-09T14:28:05.640351615Z
2025-10-09T14:28:07.151644825Z 14:28:07 default_worker.1     | INFO  2025-10-09T14:28:07.131Z pid=302 tid=ho6 jid=30c0629f7f698aca76d515ad class=Upgrade::FixParentCollections elapsed=0.529: done
2025-10-09T14:28:07.151889327Z 14:28:07 default_worker.1     | INFO  2025-10-09T14:28:07.132Z pid=302 tid=hn2 jid=cf8ad8c0b79ac4ec6e147ed7 class=Upgrade::DisambiguateUsernamesJob elapsed=0.539: done
2025-10-09T14:28:07.154671159Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [6d538e9e-b550-462d-b147-75beac7be6da] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-10-09T14:28:07.306003204Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [6d538e9e-b550-462d-b147-75beac7be6da] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-10-09T14:28:07.309222036Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [6d538e9e-b550-462d-b147-75beac7be6da] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.140
2025-10-09T14:28:07.328847664Z 14:28:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [6d538e9e-b550-462d-b147-75beac7be6da] Performed Upgrade::PruneOrphanedProblems (Job ID: 6d538e9e-b550-462d-b147-75beac7be6da) from Sidekiq(upgrade) in 188.19ms
2025-10-09T14:28:07.330298887Z 14:28:07 default_worker.1     | INFO  2025-10-09T14:28:07.329Z pid=302 tid=hmu jid=1a89013d92583c66f39212ad class=Upgrade::PruneOrphanedProblems elapsed=0.216: done
2025-10-09T14:28:33.449550734Z 14:28:33 rails.1              | [af709348-fa2b-477c-a048-71062719dddd] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1390,"duration":16.09,"view":0.0,"db":2.68,"@timestamp":"2025-10-09T14:28:33.448Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-09T14:28:34.487726383Z 14:28:34 rails.1              | [4dd1e29a-9bfe-4c30-9f2c-4369137d1aba] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":120922,"duration":992.41,"view":0.0,"db":25.03,"location":"http://172.17.0.5:3214/","@timestamp":"2025-10-09T14:28:34.486Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-09T14:28:34.555826843Z 14:28:34 rails.1              | [f9b6103a-3a43-4980-96d4-68055bdaf0eb] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1074,"duration":41.16,"view":0.0,"db":2.51,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-10-09T14:28:34.538Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-09T14:28:35.270013499Z 14:28:35 rails.1              | [ea1f1f51-69b7-4548-86be-b2b187772610] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24031,"duration":679.92,"view":522.59,"db":59.91,"@timestamp":"2025-10-09T14:28:35.269Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-10-09T14:28:35.347582904Z 14:28:35 rails.1              | [e348efae-a053-4dc5-b41a-f8715fd30832] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1178,"duration":31.65,"view":0.0,"db":4.4,"@timestamp":"2025-10-09T14:28:35.346Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-10-09T14:28:35.708031785Z 14:28:35 rails.1              | [de8641ac-00d5-4bfb-947a-c73a1b5db532] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14502,"duration":208.61,"view":0.0,"db":1.99,"location":"http://172.17.0.5:3214/","@timestamp":"2025-10-09T14:28:35.672Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-10-09T14:28:35.734758552Z 14:28:35 rails.1              | [ad97bafd-6fb2-4f3d-90cb-6e4a9c77041d] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1075,"duration":20.44,"view":0.0,"db":1.9,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-10-09T14:28:35.734Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-10-09T14:28:36.116824742Z 14:28:36 rails.1              | [38c0e44f-903a-4785-86c7-6917396c5e73] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24235,"duration":361.55,"view":235.92,"db":1.05,"@timestamp":"2025-10-09T14:28:36.111Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}