2025-09-22T11:26:59.706620941Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-09-22T11:26:59.706677786Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-09-22T11:26:59.753968255Z [mod-init] Running Docker Modification Logic
2025-09-22T11:27:00.004265162Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-09-22T11:27:00.684491692Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-09-22T11:27:01.069243147Z [mod-init] Installing linuxserver/mods:universal-redis
2025-09-22T11:27:01.093668798Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-09-22T11:27:01.094406533Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-09-22T11:27:01.113524488Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-09-22T11:27:01.116972319Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-09-22T11:27:01.117111890Z s6-rc: info: service fix-attrs: starting
2025-09-22T11:27:01.117282023Z s6-rc: info: service init-migrations: starting
2025-09-22T11:27:01.117509751Z s6-rc: info: service init-envfile: starting
2025-09-22T11:27:01.122310315Z [migrations] started
2025-09-22T11:27:01.122344845Z [migrations] no migrations found
2025-09-22T11:27:01.122794761Z s6-rc: info: service init-migrations successfully started
2025-09-22T11:27:01.123144875Z s6-rc: info: service init-adduser: starting
2025-09-22T11:27:01.123357103Z s6-rc: info: service fix-attrs successfully started
2025-09-22T11:27:01.123471423Z s6-rc: info: service legacy-cont-init: starting
2025-09-22T11:27:01.126689721Z s6-rc: info: service init-envfile successfully started
2025-09-22T11:27:01.129971287Z s6-rc: info: service legacy-cont-init successfully started
2025-09-22T11:27:01.145822788Z usermod: no changes
2025-09-22T11:27:01.151716502Z ───────────────────────────────────────
2025-09-22T11:27:01.151741633Z 
2025-09-22T11:27:01.151748947Z       ██╗     ███████╗██╗ ██████╗
2025-09-22T11:27:01.151755791Z       ██║     ██╔════╝██║██╔═══██╗
2025-09-22T11:27:01.151762424Z       ██║     ███████╗██║██║   ██║
2025-09-22T11:27:01.151768918Z       ██║     ╚════██║██║██║   ██║
2025-09-22T11:27:01.151775411Z       ███████╗███████║██║╚██████╔╝
2025-09-22T11:27:01.151782004Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-09-22T11:27:01.151788617Z 
2025-09-22T11:27:01.151794790Z    Brought to you by linuxserver.io
2025-09-22T11:27:01.151815211Z ───────────────────────────────────────
2025-09-22T11:27:01.152048200Z 
2025-09-22T11:27:01.152058941Z To support LSIO projects visit:
2025-09-22T11:27:01.152065374Z https://www.linuxserver.io/donate/
2025-09-22T11:27:01.152071717Z 
2025-09-22T11:27:01.152078240Z ───────────────────────────────────────
2025-09-22T11:27:01.152085244Z GID/UID
2025-09-22T11:27:01.152091527Z ───────────────────────────────────────
2025-09-22T11:27:01.156320250Z 
2025-09-22T11:27:01.156343216Z User UID:    911
2025-09-22T11:27:01.156352384Z User GID:    911
2025-09-22T11:27:01.156360661Z ───────────────────────────────────────
2025-09-22T11:27:01.158243902Z Linuxserver.io version: v0.123.2-ls104
2025-09-22T11:27:01.158486200Z Build-date: 2025-09-22T11:13:50+00:00
2025-09-22T11:27:01.158506531Z ───────────────────────────────────────
2025-09-22T11:27:01.158516972Z     
2025-09-22T11:27:01.178114353Z s6-rc: info: service init-adduser successfully started
2025-09-22T11:27:01.178246890Z s6-rc: info: service init-device-perms: starting
2025-09-22T11:27:01.185432395Z s6-rc: info: service init-device-perms successfully started
2025-09-22T11:27:01.185569150Z s6-rc: info: service init-os-end: starting
2025-09-22T11:27:01.186808114Z s6-rc: info: service init-os-end successfully started
2025-09-22T11:27:01.186896582Z s6-rc: info: service init-manyfold-config: starting
2025-09-22T11:27:01.187195604Z s6-rc: info: service init-config: starting
2025-09-22T11:27:01.188404167Z s6-rc: info: service init-config successfully started
2025-09-22T11:27:01.188632537Z s6-rc: info: service init-crontab-config: starting
2025-09-22T11:27:01.199685818Z s6-rc: info: service init-crontab-config successfully started
2025-09-22T11:27:01.218013032Z **** Running Manyfold database init. ****
2025-09-22T11:27:03.504296914Z `/root` is not writable.
2025-09-22T11:27:03.504485203Z Bundler will use `/tmp/bundler20250922-173-rh7iz6173' as your home directory temporarily.
2025-09-22T11:27:06.557319317Z /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-22T11:27:06.557365079Z You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T11:27:06.557372865Z Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T11:27:10.430268419Z Server: f773de2cf7ef, Context: rails, Role: web, data: {cpu: {one_min: 5.93, five_min: 4.62, fifteen_min: 4.7}, memory: 0.19525632e9, disk: {available: 815432433664, total: 938656133120, used: 123223699456}}
2025-09-22T11:27:10.430314512Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-09-22T11:27:10.430324732Z INFO  2025-09-22T11:27:08.574Z pid=173 tid=2i5: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T11:27:10.430334101Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-09-22T11:27:10.430342849Z Migrating to CreateLibraries (20210130201037)
2025-09-22T11:27:10.430350985Z == 20210130201037 CreateLibraries: migrating ==================================
2025-09-22T11:27:10.430359091Z -- create_table(:libraries)
2025-09-22T11:27:10.430369592Z    -> 0.0026s
2025-09-22T11:27:10.430379693Z == 20210130201037 CreateLibraries: migrated (0.0027s) =========================
2025-09-22T11:27:10.430389663Z 
2025-09-22T11:27:10.430399553Z Migrating to CreateModels (20210130203243)
2025-09-22T11:27:10.430408831Z == 20210130203243 CreateModels: migrating =====================================
2025-09-22T11:27:10.430416958Z -- create_table(:models)
2025-09-22T11:27:10.430424763Z    -> 0.0009s
2025-09-22T11:27:10.430432599Z == 20210130203243 CreateModels: migrated (0.0009s) ============================
2025-09-22T11:27:10.430440876Z 
2025-09-22T11:27:10.430449143Z Migrating to CreateParts (20210205230918)
2025-09-22T11:27:10.430459393Z == 20210205230918 CreateParts: migrating ======================================
2025-09-22T11:27:10.430469363Z -- create_table(:parts)
2025-09-22T11:27:10.430478161Z    -> 0.0031s
2025-09-22T11:27:10.430486007Z == 20210205230918 CreateParts: migrated (0.0032s) =============================
2025-09-22T11:27:10.430493933Z 
2025-09-22T11:27:10.430502640Z Migrating to AddFieldsToParts (20210210153744)
2025-09-22T11:27:10.430512630Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-09-22T11:27:10.430522791Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-09-22T11:27:10.430533432Z    -> 0.0008s
2025-09-22T11:27:10.430543402Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-09-22T11:27:10.430553352Z    -> 0.0003s
2025-09-22T11:27:10.430563272Z == 20210210153744 AddFieldsToParts: migrated (0.0011s) ========================
2025-09-22T11:27:10.430573423Z 
2025-09-22T11:27:10.430583052Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-09-22T11:27:10.430593213Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-09-22T11:27:10.430621019Z -- create_table(:tags, {id: :integer})
2025-09-22T11:27:10.430629335Z    -> 0.0036s
2025-09-22T11:27:10.430637321Z -- create_table(:taggings, {id: :integer})
2025-09-22T11:27:10.430645217Z    -> 0.0017s
2025-09-22T11:27:10.430653273Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T11:27:10.430661751Z    -> 0.0002s
2025-09-22T11:27:10.430671450Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-22T11:27:10.430680458Z    -> 0.0020s
2025-09-22T11:27:10.430691070Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0077s) ===============
2025-09-22T11:27:10.430701471Z 
2025-09-22T11:27:10.430711020Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-09-22T11:27:10.430719547Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-09-22T11:27:10.430729757Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-09-22T11:27:10.430739978Z    -> 0.0003s
2025-09-22T11:27:10.430749597Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T11:27:10.430760309Z    -> 0.0004s
2025-09-22T11:27:10.430770590Z -- remove_foreign_key(:taggings, :tags)
2025-09-22T11:27:10.430780580Z    -> 0.1649s
2025-09-22T11:27:10.430790460Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T11:27:10.430799678Z    -> 0.0150s
2025-09-22T11:27:10.430807815Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-09-22T11:27:10.430815931Z    -> 0.0002s
2025-09-22T11:27:10.430823757Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-09-22T11:27:10.430832454Z    -> 0.0049s
2025-09-22T11:27:10.430840330Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-09-22T11:27:10.430848587Z    -> 0.0682s
2025-09-22T11:27:10.430856352Z == 20210212143002 AddMissingUniqueIndices: migrated (0.2844s) =================
2025-09-22T11:27:10.430864278Z 
2025-09-22T11:27:10.430872094Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-09-22T11:27:10.430880000Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-09-22T11:27:10.430888006Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-09-22T11:27:10.430896012Z    -> 0.0380s
2025-09-22T11:27:10.430903728Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1167s) ===========
2025-09-22T11:27:10.430911644Z 
2025-09-22T11:27:10.430919209Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-09-22T11:27:10.430937916Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-09-22T11:27:10.430947736Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-22T11:27:10.430958017Z    -> 0.0003s
2025-09-22T11:27:10.430968318Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-09-22T11:27:10.430978989Z 
2025-09-22T11:27:10.430987837Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-09-22T11:27:10.430995843Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-09-22T11:27:10.431003979Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0007s) ==============
2025-09-22T11:27:10.431011966Z 
2025-09-22T11:27:10.431019681Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-09-22T11:27:10.431029230Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-09-22T11:27:10.431040182Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T11:27:10.431050934Z    -> 0.0079s
2025-09-22T11:27:10.431058890Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T11:27:10.431067107Z    -> 0.0002s
2025-09-22T11:27:10.431074902Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-22T11:27:10.431085033Z    -> 0.0063s
2025-09-22T11:27:10.431094973Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-22T11:27:10.431105814Z    -> 0.0012s
2025-09-22T11:27:10.431115955Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-22T11:27:10.431126626Z    -> 0.0004s
2025-09-22T11:27:10.431136486Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-22T11:27:10.431147078Z    -> 0.0001s
2025-09-22T11:27:10.431154973Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-22T11:27:10.431164032Z    -> 0.0039s
2025-09-22T11:27:10.431173771Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-22T11:27:10.431184252Z    -> 0.0001s
2025-09-22T11:27:10.431194353Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-22T11:27:10.431204553Z    -> 0.0005s
2025-09-22T11:27:10.431214383Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-22T11:27:10.431224493Z    -> 0.0002s
2025-09-22T11:27:10.431234243Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-22T11:27:10.431245085Z    -> 0.0006s
2025-09-22T11:27:10.431268272Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-22T11:27:10.431278873Z    -> 0.0001s
2025-09-22T11:27:10.431289314Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-22T11:27:10.431299745Z    -> 0.0015s
2025-09-22T11:27:10.431309525Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-22T11:27:10.431320266Z    -> 0.0002s
2025-09-22T11:27:10.431330326Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0238s) =============
2025-09-22T11:27:10.431340567Z 
2025-09-22T11:27:10.431348423Z Migrating to AddPreviewPartToModel (20210220204055)
2025-09-22T11:27:10.431356319Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-09-22T11:27:10.431364435Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-09-22T11:27:10.431372882Z    -> 0.2613s
2025-09-22T11:27:10.431380658Z == 20210220204055 AddPreviewPartToModel: migrated (0.2613s) ===================
2025-09-22T11:27:10.431388594Z 
2025-09-22T11:27:10.431396269Z Migrating to CreateCreators (20210225232756)
2025-09-22T11:27:10.431404095Z == 20210225232756 CreateCreators: migrating ===================================
2025-09-22T11:27:10.431412101Z -- create_table(:creators)
2025-09-22T11:27:10.431419927Z    -> 0.0141s
2025-09-22T11:27:10.431428584Z == 20210225232756 CreateCreators: migrated (0.0142s) ==========================
2025-09-22T11:27:10.431438614Z 
2025-09-22T11:27:10.431449657Z Migrating to AddCreatorToModels (20210225232841)
2025-09-22T11:27:10.431459907Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-09-22T11:27:10.431469597Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-09-22T11:27:10.431479477Z    -> 0.0528s
2025-09-22T11:27:10.431489106Z == 20210225232841 AddCreatorToModels: migrated (0.0528s) ======================
2025-09-22T11:27:10.431499226Z 
2025-09-22T11:27:10.431508285Z Migrating to CreateLinks (20210301230017)
2025-09-22T11:27:10.431517233Z == 20210301230017 CreateLinks: migrating ======================================
2025-09-22T11:27:10.431527594Z -- create_table(:links)
2025-09-22T11:27:10.431537353Z    -> 0.0012s
2025-09-22T11:27:10.431547113Z == 20210301230017 CreateLinks: migrated (0.0012s) =============================
2025-09-22T11:27:10.431557434Z 
2025-09-22T11:27:10.431567163Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-09-22T11:27:10.431577003Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-09-22T11:27:10.431597945Z -- remove_column(:creators, :thingiverse_user, :string)
2025-09-22T11:27:10.431606092Z    -> 0.0753s
2025-09-22T11:27:10.431613847Z -- remove_column(:creators, :cults3d_user, :string)
2025-09-22T11:27:10.431623777Z    -> 0.0042s
2025-09-22T11:27:10.431633487Z -- remove_column(:creators, :mmf_user, :string)
2025-09-22T11:27:10.431643347Z    -> 0.0154s
2025-09-22T11:27:10.431653297Z -- remove_column(:creators, :cgtrader_user, :string)
2025-09-22T11:27:10.431663146Z    -> 0.0041s
2025-09-22T11:27:10.431673137Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.1015s) ==============
2025-09-22T11:27:10.431682906Z 
2025-09-22T11:27:10.431692395Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-09-22T11:27:10.431702536Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-09-22T11:27:10.431711804Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-09-22T11:27:10.431719820Z    -> 0.0652s
2025-09-22T11:27:10.431727807Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0652s) ==
2025-09-22T11:27:10.431735963Z 
2025-09-22T11:27:10.431743759Z Migrating to AddYUpToParts (20210318202638)
2025-09-22T11:27:10.431751875Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-09-22T11:27:10.431761033Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-09-22T11:27:10.431771054Z    -> 0.0165s
2025-09-22T11:27:10.431780633Z == 20210318202638 AddYUpToParts: migrated (0.0165s) ===========================
2025-09-22T11:27:10.431790383Z 
2025-09-22T11:27:10.431798369Z Migrating to CreateImages (20210321164508)
2025-09-22T11:27:10.431808860Z == 20210321164508 CreateImages: migrating =====================================
2025-09-22T11:27:10.431816896Z -- create_table(:images)
2025-09-22T11:27:10.431824992Z    -> 0.0180s
2025-09-22T11:27:10.431832828Z == 20210321164508 CreateImages: migrated (0.0180s) ============================
2025-09-22T11:27:10.431841065Z 
2025-09-22T11:27:10.431868339Z Migrating to CreateDelayedJobs (20210330215825)
2025-09-22T11:27:10.431879221Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-09-22T11:27:10.431887258Z -- create_table(:delayed_jobs)
2025-09-22T11:27:10.431895224Z    -> 0.0117s
2025-09-22T11:27:11.647958383Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-09-22T11:27:11.647999235Z    -> 0.0002s
2025-09-22T11:27:11.648008905Z == 20210330215825 CreateDelayedJobs: migrated (0.0120s) =======================
2025-09-22T11:27:11.648017462Z 
2025-09-22T11:27:11.648052172Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-09-22T11:27:11.648060318Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-09-22T11:27:11.648068605Z -- rename_table(:parts, :model_files)
2025-09-22T11:27:11.648076461Z    -> 0.0018s
2025-09-22T11:27:11.648084737Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-09-22T11:27:11.648092733Z    -> 0.0381s
2025-09-22T11:27:11.648100579Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0400s) =================
2025-09-22T11:27:11.648108545Z 
2025-09-22T11:27:11.648116381Z Migrating to RemoveImagesTable (20220106220519)
2025-09-22T11:27:11.648124217Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-09-22T11:27:11.648132604Z -- drop_table(:images)
2025-09-22T11:27:11.648140560Z    -> 0.0003s
2025-09-22T11:27:11.648148916Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-09-22T11:27:11.648156903Z 
2025-09-22T11:27:11.648164698Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-09-22T11:27:11.648172574Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-09-22T11:27:11.648180510Z -- table_exists?(:active_storage_blobs)
2025-09-22T11:27:11.648188336Z    -> 0.0001s
2025-09-22T11:27:11.648196392Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0002s) ======
2025-09-22T11:27:11.648204318Z 
2025-09-22T11:27:11.648212003Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-09-22T11:27:11.648220090Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-09-22T11:27:11.648228236Z -- table_exists?(:active_storage_blobs)
2025-09-22T11:27:11.648236102Z    -> 0.0001s
2025-09-22T11:27:11.648244168Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-09-22T11:27:11.648252355Z 
2025-09-22T11:27:11.648259900Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-09-22T11:27:11.648268447Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-09-22T11:27:11.648276604Z -- table_exists?(:active_storage_blobs)
2025-09-22T11:27:11.648284620Z    -> 0.0001s
2025-09-22T11:27:11.648292576Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0002s) 
2025-09-22T11:27:11.648300752Z 
2025-09-22T11:27:11.648308498Z Migrating to DeviseCreateUsers (20220614210023)
2025-09-22T11:27:11.648316574Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-09-22T11:27:11.648324690Z -- create_table(:users)
2025-09-22T11:27:11.648332546Z    -> 0.0012s
2025-09-22T11:27:11.648360853Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-09-22T11:27:11.648369691Z    -> 0.0016s
2025-09-22T11:27:11.648377447Z == 20220614210023 DeviseCreateUsers: migrated (0.0029s) =======================
2025-09-22T11:27:11.648385362Z 
2025-09-22T11:27:11.648392978Z Migrating to AddUsernameToUsers (20220614211256)
2025-09-22T11:27:11.648401084Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-09-22T11:27:11.648410233Z -- add_column(:users, :username, :string, {null: false})
2025-09-22T11:27:11.648418419Z    -> 0.0226s
2025-09-22T11:27:11.648426325Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-09-22T11:27:11.648434501Z    -> 0.0002s
2025-09-22T11:27:11.648442297Z == 20220614211256 AddUsernameToUsers: migrated (0.0228s) ======================
2025-09-22T11:27:11.648450223Z 
2025-09-22T11:27:11.648457898Z Migrating to AddAdminToUsers (20220614213902)
2025-09-22T11:27:11.648465744Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-09-22T11:27:11.648473911Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-22T11:27:11.648482137Z    -> 0.0007s
2025-09-22T11:27:11.648490514Z == 20220614213902 AddAdminToUsers: migrated (0.0007s) =========================
2025-09-22T11:27:11.648498520Z 
2025-09-22T11:27:11.648506597Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-09-22T11:27:11.648514643Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-09-22T11:27:11.648522659Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-09-22T11:27:11.648531787Z    -> 0.0011s
2025-09-22T11:27:11.648539623Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0011s) =============
2025-09-22T11:27:11.648547519Z 
2025-09-22T11:27:11.648555194Z Migrating to CreateSettings (20220619174307)
2025-09-22T11:27:11.648563020Z == 20220619174307 CreateSettings: migrating ===================================
2025-09-22T11:27:11.648570956Z -- create_table(:settings)
2025-09-22T11:27:11.648578722Z    -> 0.0028s
2025-09-22T11:27:11.648586487Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-09-22T11:27:11.648594764Z    -> 0.0002s
2025-09-22T11:27:11.648602590Z == 20220619174307 CreateSettings: migrated (0.0030s) ==========================
2025-09-22T11:27:11.648610556Z 
2025-09-22T11:27:11.648618241Z Migrating to AddScaleFactorToModels (20220626152444)
2025-09-22T11:27:11.648626147Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-09-22T11:27:11.648643582Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-09-22T11:27:11.648651598Z    -> 0.0100s
2025-09-22T11:27:11.648659434Z == 20220626152444 AddScaleFactorToModels: migrated (0.0123s) ==================
2025-09-22T11:27:11.648667380Z 
2025-09-22T11:27:11.648675066Z Migrating to AddDigestToModelFiles (20220702202932)
2025-09-22T11:27:11.648682901Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-09-22T11:27:11.648691088Z -- add_column(:model_files, :digest, :string)
2025-09-22T11:27:11.648698914Z    -> 0.0025s
2025-09-22T11:27:11.648706709Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-09-22T11:27:11.648714756Z    -> 0.0002s
2025-09-22T11:27:11.648722752Z == 20220702202932 AddDigestToModelFiles: migrated (0.0046s) ===================
2025-09-22T11:27:11.648730918Z 
2025-09-22T11:27:11.648738744Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-09-22T11:27:11.648746610Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-09-22T11:27:11.648755377Z -- 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-09-22T11:27:11.648766931Z    -> 0.0008s
2025-09-22T11:27:11.648774766Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0011s) ==============
2025-09-22T11:27:11.648782782Z 
2025-09-22T11:27:11.648790468Z Migrating to CreateProblems (20221210001132)
2025-09-22T11:27:11.648798554Z == 20221210001132 CreateProblems: migrating ===================================
2025-09-22T11:27:11.648806721Z -- create_table(:problems)
2025-09-22T11:27:11.648814617Z    -> 0.0008s
2025-09-22T11:27:11.648822713Z == 20221210001132 CreateProblems: migrated (0.0012s) ==========================
2025-09-22T11:27:11.648831020Z 
2025-09-22T11:27:11.648838976Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-09-22T11:27:11.648846892Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-09-22T11:27:11.648854817Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0153s) ========
2025-09-22T11:27:11.648862753Z 
2025-09-22T11:27:11.648870389Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-09-22T11:27:11.648878255Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-09-22T11:27:11.648886431Z -- create_table(:favorites, {force: true})
2025-09-22T11:27:11.648894287Z    -> 0.0038s
2025-09-22T11:27:11.648911381Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-09-22T11:27:11.648919959Z    -> 0.0001s
2025-09-22T11:27:11.648928115Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-09-22T11:27:11.648936752Z    -> 0.0001s
2025-09-22T11:27:11.648944769Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-09-22T11:27:11.648953666Z    -> 0.0001s
2025-09-22T11:27:11.648961913Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0047s) ================
2025-09-22T11:27:11.648970080Z 
2025-09-22T11:27:11.648977875Z Migrating to MovePrintedToFavorites (20221220223040)
2025-09-22T11:27:11.648985731Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-09-22T11:27:11.648993887Z == 20221220223040 MovePrintedToFavorites: migrated (0.3654s) ==================
2025-09-22T11:27:11.649001823Z 
2025-09-22T11:27:11.649009499Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-09-22T11:27:11.649017425Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-09-22T11:27:11.649027696Z -- remove_column(:model_files, :printed, :boolean)
2025-09-22T11:27:11.649035642Z    -> 0.0295s
2025-09-22T11:27:11.649043708Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0298s) ===============
2025-09-22T11:27:11.649051774Z 
2025-09-22T11:27:11.649059560Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-09-22T11:27:11.649068067Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-09-22T11:27:11.649076123Z -- add_column(:models, :notes, :text)
2025-09-22T11:27:11.649083969Z    -> 0.0018s
2025-09-22T11:27:11.649092456Z -- add_column(:models, :excerpt, :text)
2025-09-22T11:27:11.649100482Z    -> 0.0025s
2025-09-22T11:27:11.649108298Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0043s) =================
2025-09-22T11:27:11.649116264Z 
2025-09-22T11:27:11.649124861Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-09-22T11:27:11.649133809Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-09-22T11:27:11.649142537Z -- add_column(:creators, :notes, :text)
2025-09-22T11:27:11.649151054Z    -> 0.0006s
2025-09-22T11:27:11.649159441Z -- add_column(:creators, :excerpt, :text)
2025-09-22T11:27:11.649167287Z    -> 0.0005s
2025-09-22T11:27:11.649175042Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0011s) ===============
2025-09-22T11:27:11.649182968Z 
2025-09-22T11:27:11.649190563Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-09-22T11:27:11.649207367Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-09-22T11:27:11.649215373Z -- add_column(:model_files, :notes, :text)
2025-09-22T11:27:11.649223189Z    -> 0.0008s
2025-09-22T11:27:11.649232708Z -- add_column(:model_files, :excerpt, :text)
2025-09-22T11:27:11.649240604Z    -> 0.0005s
2025-09-22T11:27:11.649248410Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0013s) =============
2025-09-22T11:27:11.649256356Z 
2025-09-22T11:27:11.649263981Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-09-22T11:27:11.649271837Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-09-22T11:27:11.649279743Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0220s) =================
2025-09-22T11:27:11.649287669Z 
2025-09-22T11:27:11.649295384Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-09-22T11:27:11.649303300Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-09-22T11:27:11.649311417Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-09-22T11:27:11.649319834Z    -> 0.0459s
2025-09-22T11:27:11.649327639Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0460s) =============
2025-09-22T11:27:11.649335585Z 
2025-09-22T11:27:11.649343231Z Migrating to RenameExcerptToCaption (20230222155910)
2025-09-22T11:27:11.649351076Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-09-22T11:27:11.649359103Z -- rename_column(:creators, :excerpt, :caption)
2025-09-22T11:27:11.649366928Z    -> 0.0237s
2025-09-22T11:27:11.649374774Z -- rename_column(:models, :excerpt, :caption)
2025-09-22T11:27:11.649382640Z    -> 0.0262s
2025-09-22T11:27:11.649390676Z -- rename_column(:model_files, :excerpt, :caption)
2025-09-22T11:27:11.649398692Z    -> 0.0201s
2025-09-22T11:27:11.649406518Z == 20230222155910 RenameExcerptToCaption: migrated (0.0729s) ==================
2025-09-22T11:27:11.649414474Z 
2025-09-22T11:27:11.649422450Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-09-22T11:27:11.649430376Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-09-22T11:27:11.649438372Z -- add_column(:libraries, :notes, :string)
2025-09-22T11:27:11.649446208Z    -> 0.0022s
2025-09-22T11:27:11.649454294Z -- add_column(:libraries, :caption, :string)
2025-09-22T11:27:12.258517521Z    -> 0.0005s
2025-09-22T11:27:12.258556339Z -- add_column(:libraries, :name, :string)
2025-09-22T11:27:12.258566610Z    -> 0.0005s
2025-09-22T11:27:12.258604556Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0122s) ============
2025-09-22T11:27:12.258614697Z 
2025-09-22T11:27:12.258622913Z Migrating to AddTagregexToLibrary (20230305180823)
2025-09-22T11:27:12.258631130Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-09-22T11:27:12.258639356Z -- add_column(:libraries, :tag_regex, :text)
2025-09-22T11:27:12.258647493Z    -> 0.0020s
2025-09-22T11:27:12.258658014Z == 20230305180823 AddTagregexToLibrary: migrated (0.0037s) ====================
2025-09-22T11:27:12.258666341Z 
2025-09-22T11:27:12.258674206Z Migrating to AddIconToLibrary (20230307215826)
2025-09-22T11:27:12.258682493Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-09-22T11:27:12.258690770Z -- add_column(:libraries, :icon, :text)
2025-09-22T11:27:12.258698826Z    -> 0.0020s
2025-09-22T11:27:12.258706642Z == 20230307215826 AddIconToLibrary: migrated (0.0037s) ========================
2025-09-22T11:27:12.258714578Z 
2025-09-22T11:27:12.258722474Z Migrating to CreateCollection (20230308004237)
2025-09-22T11:27:12.258730780Z == 20230308004237 CreateCollection: migrating =================================
2025-09-22T11:27:12.258738696Z -- create_table(:collections)
2025-09-22T11:27:12.258746442Z    -> 0.0030s
2025-09-22T11:27:12.258754278Z == 20230308004237 CreateCollection: migrated (0.0073s) ========================
2025-09-22T11:27:12.258762274Z 
2025-09-22T11:27:12.258769879Z Migrating to AddCollectionToModels (20230308005021)
2025-09-22T11:27:12.258777675Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-09-22T11:27:12.258785631Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-09-22T11:27:12.258794028Z    -> 0.0200s
2025-09-22T11:27:12.258801793Z == 20230308005021 AddCollectionToModels: migrated (0.0237s) ===================
2025-09-22T11:27:12.258809709Z 
2025-09-22T11:27:12.258817345Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-09-22T11:27:12.258825160Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-09-22T11:27:12.258832996Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0015s) =============
2025-09-22T11:27:12.258840942Z 
2025-09-22T11:27:12.258848507Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-09-22T11:27:12.258856423Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-09-22T11:27:12.258864389Z -- rename_column(:collections, :excerpt, :caption)
2025-09-22T11:27:12.258872215Z    -> 0.0042s
2025-09-22T11:27:12.258880001Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0042s) ========
2025-09-22T11:27:12.258897346Z 
2025-09-22T11:27:12.258905051Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-09-22T11:27:12.258912897Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-09-22T11:27:12.258920813Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-09-22T11:27:12.258929100Z 
2025-09-22T11:27:12.258936775Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-09-22T11:27:12.258945923Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-09-22T11:27:12.258954581Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-09-22T11:27:12.258964040Z    -> 0.0022s
2025-09-22T11:27:12.258971946Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0022s) ===============
2025-09-22T11:27:12.258979962Z 
2025-09-22T11:27:12.258987918Z Migrating to AddCollectionToCollections (20230324000000)
2025-09-22T11:27:12.258996185Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-09-22T11:27:12.259004161Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-09-22T11:27:12.259012317Z    -> 0.0063s
2025-09-22T11:27:12.259021806Z == 20230324000000 AddCollectionToCollections: migrated (0.0084s) ==============
2025-09-22T11:27:12.259029832Z 
2025-09-22T11:27:12.259037598Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-09-22T11:27:12.259045524Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-09-22T11:27:12.259053480Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0421s) =========
2025-09-22T11:27:12.259062057Z 
2025-09-22T11:27:12.259069823Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-09-22T11:27:12.259078831Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-09-22T11:27:12.259089472Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0074s) 
2025-09-22T11:27:12.259099523Z 
2025-09-22T11:27:12.259108771Z Migrating to AddSlugs (20230615135601)
2025-09-22T11:27:12.259116868Z == 20230615135601 AddSlugs: migrating =========================================
2025-09-22T11:27:12.259125124Z -- add_column(:models, :slug, :string)
2025-09-22T11:27:12.259133190Z    -> 0.0028s
2025-09-22T11:27:12.259141457Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-09-22T11:27:12.259150425Z    -> 0.0023s
2025-09-22T11:27:12.259158411Z -- add_column(:collections, :slug, :string)
2025-09-22T11:27:12.259167610Z    -> 0.0005s
2025-09-22T11:27:12.259189554Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-09-22T11:27:12.259198311Z    -> 0.0001s
2025-09-22T11:27:12.259206738Z -- add_column(:creators, :slug, :string)
2025-09-22T11:27:12.259215426Z    -> 0.0005s
2025-09-22T11:27:12.259224023Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-09-22T11:27:12.259233422Z    -> 0.0001s
2025-09-22T11:27:12.259241899Z == 20230615135601 AddSlugs: migrated (0.0069s) ================================
2025-09-22T11:27:12.259251328Z 
2025-09-22T11:27:12.259261569Z Migrating to GenerateSlugs (20230617222353)
2025-09-22T11:27:12.259272050Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-09-22T11:27:12.259280467Z == 20230617222353 GenerateSlugs: migrated (0.0577s) ===========================
2025-09-22T11:27:12.259289114Z 
2025-09-22T11:27:12.259296840Z Migrating to MakeNamesUnique (20230628194944)
2025-09-22T11:27:12.259305988Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-09-22T11:27:12.259315167Z == 20230628194944 MakeNamesUnique: migrated (0.0036s) =========================
2025-09-22T11:27:12.259323614Z 
2025-09-22T11:27:12.259331329Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-09-22T11:27:12.259339576Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-09-22T11:27:12.259347492Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-09-22T11:27:12.259355718Z    -> 0.0022s
2025-09-22T11:27:12.259363534Z -- remove_index(:creators, :slug)
2025-09-22T11:27:12.259371741Z    -> 0.0004s
2025-09-22T11:27:12.259379636Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-09-22T11:27:12.259387723Z    -> 0.0001s
2025-09-22T11:27:12.259395528Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-09-22T11:27:12.259403655Z    -> 0.0001s
2025-09-22T11:27:12.259411481Z -- remove_index(:collections, :slug)
2025-09-22T11:27:12.259419356Z    -> 0.0254s
2025-09-22T11:27:12.259427162Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-09-22T11:27:12.259435218Z    -> 0.0006s
2025-09-22T11:27:12.259443054Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0294s) ======
2025-09-22T11:27:12.259451050Z 
2025-09-22T11:27:12.259458646Z Migrating to AddSizeToModelFiles (20230707082403)
2025-09-22T11:27:12.259466431Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-09-22T11:27:12.259474568Z -- add_column(:model_files, :size, :integer)
2025-09-22T11:27:12.259491983Z    -> 0.0006s
2025-09-22T11:27:12.259499808Z == 20230707082403 AddSizeToModelFiles: migrated (0.0010s) =====================
2025-09-22T11:27:12.259507694Z 
2025-09-22T11:27:12.259515310Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-09-22T11:27:12.259523155Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-09-22T11:27:12.259531121Z -- change_column(:model_files, :size, :bigint)
2025-09-22T11:27:12.259539017Z    -> 0.0092s
2025-09-22T11:27:12.259547074Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0096s) ==================
2025-09-22T11:27:12.259555230Z 
2025-09-22T11:27:12.259562845Z Migrating to AddNoteToProblems (20230711111009)
2025-09-22T11:27:12.259570681Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-09-22T11:27:12.259578898Z -- add_column(:problems, :note, :string, {default: nil})
2025-09-22T11:27:12.259587044Z    -> 0.0009s
2025-09-22T11:27:12.259594810Z == 20230711111009 AddNoteToProblems: migrated (0.0020s) =======================
2025-09-22T11:27:12.259602736Z 
2025-09-22T11:27:12.259610301Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-09-22T11:27:12.259618477Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-09-22T11:27:12.259627706Z -- 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-09-22T11:27:12.259640912Z    -> 0.0006s
2025-09-22T11:27:12.259648909Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-09-22T11:27:12.259656834Z 
2025-09-22T11:27:12.259664440Z Migrating to AddLicenseToModel (20240127143358)
2025-09-22T11:27:12.259672326Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-09-22T11:27:12.259680212Z -- add_column(:models, :license, :string)
2025-09-22T11:27:12.259688037Z    -> 0.0005s
2025-09-22T11:27:12.259695773Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-09-22T11:27:12.259703719Z 
2025-09-22T11:27:12.259711344Z Migrating to AddIgnoredToProblems (20240131134832)
2025-09-22T11:27:12.259719170Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-09-22T11:27:12.259729300Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-09-22T11:27:12.259739571Z    -> 0.0007s
2025-09-22T11:27:12.259748870Z == 20240131134832 AddIgnoredToProblems: migrated (0.0007s) ====================
2025-09-22T11:27:12.259766816Z 
2025-09-22T11:27:12.259774742Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-09-22T11:27:12.259782878Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-09-22T11:27:12.259791195Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-09-22T11:27:12.259799532Z    -> 0.0093s
2025-09-22T11:27:12.259808169Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0093s) ======
2025-09-22T11:27:12.259818139Z 
2025-09-22T11:27:12.259827769Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-09-22T11:27:12.259837188Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-09-22T11:27:12.259865875Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-09-22T11:27:12.259881076Z    -> 0.0006s
2025-09-22T11:27:12.259890274Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-09-22T11:27:12.259898311Z 
2025-09-22T11:27:12.259905946Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-09-22T11:27:12.259913752Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-09-22T11:27:12.259921728Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-09-22T11:27:12.259929914Z    -> 0.0002s
2025-09-22T11:27:12.259938051Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-09-22T11:27:12.259946558Z    -> 0.0010s
2025-09-22T11:27:12.259954744Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-09-22T11:27:12.259963482Z    -> 0.0001s
2025-09-22T11:27:12.259971678Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-09-22T11:27:12.259980416Z    -> 0.0046s
2025-09-22T11:27:12.966060847Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0060s) =================
2025-09-22T11:27:12.966105848Z 
2025-09-22T11:27:12.966114826Z Migrating to CreateFlipperTables (20240306095646)
2025-09-22T11:27:12.966123082Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-09-22T11:27:12.966131349Z -- create_table(:flipper_features)
2025-09-22T11:27:12.966139205Z    -> 0.0031s
2025-09-22T11:27:12.966147371Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-09-22T11:27:12.966155698Z    -> 0.0049s
2025-09-22T11:27:12.966163774Z -- create_table(:flipper_gates)
2025-09-22T11:27:12.966188604Z    -> 0.0003s
2025-09-22T11:27:12.966196590Z -- 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-09-22T11:27:12.966205147Z    -> 0.0002s
2025-09-22T11:27:12.966212883Z == 20240306095646 CreateFlipperTables: migrated (0.0086s) =====================
2025-09-22T11:27:12.966220849Z 
2025-09-22T11:27:12.966228504Z Migrating to RolifyCreateRoles (20240319155251)
2025-09-22T11:27:12.966236360Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-09-22T11:27:12.966244517Z -- create_table(:roles)
2025-09-22T11:27:12.966252473Z    -> 0.0432s
2025-09-22T11:27:12.966260218Z -- create_table(:users_roles, {id: false})
2025-09-22T11:27:12.966268134Z    -> 0.0006s
2025-09-22T11:27:12.966275810Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-09-22T11:27:12.966284046Z    -> 0.0053s
2025-09-22T11:27:12.966291732Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-09-22T11:27:12.966299918Z    -> 0.0002s
2025-09-22T11:27:12.966308055Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-09-22T11:27:12.966316151Z    -> 0.0001s
2025-09-22T11:27:12.966323806Z == 20240319155251 RolifyCreateRoles: migrated (0.0670s) =======================
2025-09-22T11:27:12.966331863Z 
2025-09-22T11:27:12.966339398Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-09-22T11:27:12.966347364Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-09-22T11:27:12.966355169Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0100s) ==================
2025-09-22T11:27:12.966363065Z 
2025-09-22T11:27:12.966370691Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-09-22T11:27:12.966378486Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-09-22T11:27:12.966386302Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-22T11:27:12.966394148Z    -> 0.0269s
2025-09-22T11:27:12.966401753Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0285s) ====================
2025-09-22T11:27:12.966409589Z 
2025-09-22T11:27:12.966417084Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-09-22T11:27:12.966424860Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-09-22T11:27:12.966433407Z -- add_column(:users, :reset_password_token, :string)
2025-09-22T11:27:12.966441203Z    -> 0.0012s
2025-09-22T11:27:12.966448908Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-09-22T11:27:12.966468508Z    -> 0.0002s
2025-09-22T11:27:12.966476654Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0037s) ============
2025-09-22T11:27:12.966484730Z 
2025-09-22T11:27:12.966492376Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-09-22T11:27:12.966500181Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-09-22T11:27:12.966508117Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0270s) ==============
2025-09-22T11:27:12.966516224Z 
2025-09-22T11:27:12.966524140Z Migrating to AddRememberableToUsers (20240410221112)
2025-09-22T11:27:12.966532116Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-09-22T11:27:12.966540523Z -- add_column(:users, :remember_created_at, :datetime)
2025-09-22T11:27:12.966548318Z    -> 0.0035s
2025-09-22T11:27:12.966556425Z == 20240410221112 AddRememberableToUsers: migrated (0.0048s) ==================
2025-09-22T11:27:12.966564601Z 
2025-09-22T11:27:12.966572497Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-09-22T11:27:12.966580433Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-09-22T11:27:12.966588459Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-09-22T11:27:12.966596385Z    -> 0.0007s
2025-09-22T11:27:12.966604301Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0021s) ===========
2025-09-22T11:27:12.966612307Z 
2025-09-22T11:27:12.966620043Z Migrating to DropDelayedJobs (20240418112821)
2025-09-22T11:27:12.966627949Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-09-22T11:27:12.966636035Z -- drop_table(:delayed_jobs)
2025-09-22T11:27:12.966643891Z    -> 0.0019s
2025-09-22T11:27:12.966651757Z == 20240418112821 DropDelayedJobs: migrated (0.0128s) =========================
2025-09-22T11:27:12.966659813Z 
2025-09-22T11:27:12.966669653Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-09-22T11:27:12.966677839Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-09-22T11:27:12.966685885Z -- add_column(:users, :interface_language, :string)
2025-09-22T11:27:12.966693711Z    -> 0.0007s
2025-09-22T11:27:12.966701888Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0049s) =============
2025-09-22T11:27:12.966709803Z 
2025-09-22T11:27:12.966717399Z Migrating to AddLockableToUsers (20240610120318)
2025-09-22T11:27:12.966725575Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-09-22T11:27:12.966733631Z -- change_table(:users)
2025-09-22T11:27:12.966751247Z    -> 0.0019s
2025-09-22T11:27:12.966759053Z == 20240610120318 AddLockableToUsers: migrated (0.0025s) ======================
2025-09-22T11:27:12.966766908Z 
2025-09-22T11:27:12.966774654Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-09-22T11:27:12.966782480Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-09-22T11:27:12.966790356Z -- add_column(:model_files, :attachment_data, :json)
2025-09-22T11:27:12.966798101Z    -> 0.0009s
2025-09-22T11:27:12.966805797Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0012s) ===========
2025-09-22T11:27:12.966813783Z 
2025-09-22T11:27:12.966821318Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-09-22T11:27:12.966829625Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-09-22T11:27:12.966837881Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0138s) ==================
2025-09-22T11:27:12.966845958Z 
2025-09-22T11:27:12.966854114Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-09-22T11:27:12.966861870Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-09-22T11:27:12.966869876Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-09-22T11:27:12.966878082Z    -> 0.0007s
2025-09-22T11:27:12.966885788Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0027s) ============
2025-09-22T11:27:12.966893634Z 
2025-09-22T11:27:12.966901479Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-09-22T11:27:12.966909355Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-09-22T11:27:12.966917211Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-09-22T11:27:12.966925077Z    -> 0.0006s
2025-09-22T11:27:12.966932812Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-09-22T11:27:12.966940638Z    -> 0.0006s
2025-09-22T11:27:12.966948364Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-09-22T11:27:12.966956179Z    -> 0.0006s
2025-09-22T11:27:12.966963935Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-09-22T11:27:12.966971791Z    -> 0.0053s
2025-09-22T11:27:12.966979486Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-09-22T11:27:12.966987372Z    -> 0.0006s
2025-09-22T11:27:12.966995068Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0090s) ====================
2025-09-22T11:27:12.967002924Z 
2025-09-22T11:27:12.967010459Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-09-22T11:27:12.967018224Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-09-22T11:27:12.967042032Z -- remove_index(:libraries, :path)
2025-09-22T11:27:12.967049798Z    -> 0.0010s
2025-09-22T11:27:12.967057493Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0018s) ================
2025-09-22T11:27:12.967065309Z 
2025-09-22T11:27:12.967072834Z Migrating to CreateFederailsActors (20240727113215)
2025-09-22T11:27:12.967080590Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-09-22T11:27:12.967088486Z -- create_table(:federails_actors)
2025-09-22T11:27:12.967096161Z    -> 0.0010s
2025-09-22T11:27:12.967103927Z -- foreign_key_exists?(:federails_actors, :users)
2025-09-22T11:27:12.967111843Z    -> 0.0017s
2025-09-22T11:27:12.967119538Z -- remove_foreign_key(:federails_actors, :users)
2025-09-22T11:27:12.967127284Z    -> 0.0120s
2025-09-22T11:27:12.967134999Z -- remove_index(:federails_actors, :user_id)
2025-09-22T11:27:12.967142745Z    -> 0.0004s
2025-09-22T11:27:12.967150541Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-09-22T11:27:12.967158617Z    -> 0.0001s
2025-09-22T11:27:12.967166633Z -- add_foreign_key(:federails_actors, :users)
2025-09-22T11:27:12.967174379Z    -> 0.0100s
2025-09-22T11:27:12.967182084Z == 20240727113215 CreateFederailsActors: migrated (0.0260s) ===================
2025-09-22T11:27:12.967190040Z 
2025-09-22T11:27:12.967197605Z Migrating to CreateFederailsFollowings (20240727113216)
2025-09-22T11:27:12.967206002Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-09-22T11:27:12.967213948Z -- create_table(:federails_followings)
2025-09-22T11:27:12.967221684Z    -> 0.0027s
2025-09-22T11:27:12.967229470Z == 20240727113216 CreateFederailsFollowings: migrated (0.0027s) ===============
2025-09-22T11:27:12.967237386Z 
2025-09-22T11:27:12.967245071Z Migrating to CreateFederailsActivities (20240727113217)
2025-09-22T11:27:12.967252887Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-09-22T11:27:12.967260763Z -- create_table(:federails_activities)
2025-09-22T11:27:12.967268518Z    -> 0.0104s
2025-09-22T11:27:12.967276234Z == 20240727113217 CreateFederailsActivities: migrated (0.0104s) ===============
2025-09-22T11:27:12.967284100Z 
2025-09-22T11:27:12.967292106Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-09-22T11:27:12.967300543Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-09-22T11:27:12.967309661Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-09-22T11:27:12.967317747Z    -> 0.0180s
2025-09-22T11:27:12.967334872Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-09-22T11:27:12.967342938Z    -> 0.0008s
2025-09-22T11:27:12.967350804Z -- change_table(:federails_actors)
2025-09-22T11:27:12.967358600Z    -> 0.0102s
2025-09-22T11:27:12.967366596Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0291s) =======
2025-09-22T11:27:12.967375123Z 
2025-09-22T11:27:12.967382768Z Migrating to CreateFederailsActors (20240731165647)
2025-09-22T11:27:12.967390584Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-09-22T11:27:12.967398460Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-09-22T11:27:12.967406406Z 
2025-09-22T11:27:12.967414021Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-09-22T11:27:12.967421877Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-09-22T11:27:12.967430013Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-09-22T11:27:12.967437919Z 
2025-09-22T11:27:12.967445515Z Migrating to BackfillActivities (20240805111500)
2025-09-22T11:27:12.967453280Z == 20240805111500 BackfillActivities: migrating ===============================
2025-09-22T11:27:12.967461176Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-09-22T11:27:12.967470605Z 
2025-09-22T11:27:12.967478170Z Migrating to CreateCaberRelations (20240827155630)
2025-09-22T11:27:12.967485946Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-09-22T11:27:12.967493992Z -- create_table(:caber_relations)
2025-09-22T11:27:12.967501968Z    -> 0.0412s
2025-09-22T11:27:12.967509704Z == 20240827155630 CreateCaberRelations: migrated (0.0413s) ====================
2025-09-22T11:27:12.967517790Z 
2025-09-22T11:27:12.967525486Z Migrating to AddDefaultAccessControls (20240830121749)
2025-09-22T11:27:12.967533692Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-09-22T11:27:12.967541778Z == 20240830121749 AddDefaultAccessControls: migrated (0.0317s) ================
2025-09-22T11:27:12.967549815Z 
2025-09-22T11:27:12.967558111Z Migrating to RenameDefaultRoles (20240830151650)
2025-09-22T11:27:13.655043780Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-09-22T11:27:13.655090344Z == 20240830151650 RenameDefaultRoles: migrated (0.0460s) ======================
2025-09-22T11:27:13.655099933Z 
2025-09-22T11:27:13.655108069Z Migrating to AddPublicIDsToModels (20240904151944)
2025-09-22T11:27:13.655116226Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-09-22T11:27:13.655143030Z -- add_column(:models, :public_id, :string)
2025-09-22T11:27:13.655151427Z    -> 0.0016s
2025-09-22T11:27:13.655159803Z -- add_index(:models, :public_id)
2025-09-22T11:27:13.655167930Z    -> 0.0029s
2025-09-22T11:27:13.655176056Z -- add_column(:model_files, :public_id, :string)
2025-09-22T11:27:13.655185205Z    -> 0.0007s
2025-09-22T11:27:13.655193742Z -- add_index(:model_files, :public_id)
2025-09-22T11:27:13.655202469Z    -> 0.0001s
2025-09-22T11:27:13.655211317Z -- add_column(:problems, :public_id, :string)
2025-09-22T11:27:13.655219884Z    -> 0.0007s
2025-09-22T11:27:13.655227850Z -- add_index(:problems, :public_id)
2025-09-22T11:27:13.655236067Z    -> 0.0001s
2025-09-22T11:27:13.655243983Z -- add_column(:creators, :public_id, :string)
2025-09-22T11:27:13.655252219Z    -> 0.0007s
2025-09-22T11:27:13.655260145Z -- add_index(:creators, :public_id)
2025-09-22T11:27:13.655268101Z    -> 0.0002s
2025-09-22T11:27:13.655275997Z -- add_column(:collections, :public_id, :string)
2025-09-22T11:27:13.655284114Z    -> 0.0007s
2025-09-22T11:27:13.655292050Z -- add_index(:collections, :public_id)
2025-09-22T11:27:13.655300036Z    -> 0.0001s
2025-09-22T11:27:13.655307962Z -- add_column(:libraries, :public_id, :string)
2025-09-22T11:27:13.655315938Z    -> 0.0007s
2025-09-22T11:27:13.655323834Z -- add_index(:libraries, :public_id)
2025-09-22T11:27:13.655331780Z    -> 0.0001s
2025-09-22T11:27:13.655339866Z == 20240904151944 AddPublicIDsToModels: migrated (0.0089s) ====================
2025-09-22T11:27:13.655348123Z 
2025-09-22T11:27:13.655355968Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-09-22T11:27:13.655364005Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-09-22T11:27:13.655373113Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:13.655383343Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0398s) ==============
2025-09-22T11:27:13.655393744Z 
2025-09-22T11:27:13.655402532Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-09-22T11:27:13.655410749Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-09-22T11:27:13.655419366Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-09-22T11:27:13.655428063Z 
2025-09-22T11:27:13.655436290Z Migrating to DeduplicateRoles (20240923114515)
2025-09-22T11:27:13.655444667Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-09-22T11:27:13.655452823Z == 20240923114515 DeduplicateRoles: migrated (0.1537s) ========================
2025-09-22T11:27:13.655475309Z 
2025-09-22T11:27:13.655484788Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-09-22T11:27:13.655492944Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-09-22T11:27:13.655501612Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-22T11:27:13.655510219Z    -> 0.1697s
2025-09-22T11:27:13.655519928Z -- add_index(:models, :name_lower)
2025-09-22T11:27:13.655528255Z    -> 0.0002s
2025-09-22T11:27:13.655536351Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-22T11:27:13.655545690Z    -> 0.0074s
2025-09-22T11:27:13.655556111Z -- add_index(:creators, :name_lower)
2025-09-22T11:27:13.655566151Z    -> 0.0001s
2025-09-22T11:27:13.655574378Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-22T11:27:13.655582715Z    -> 0.0098s
2025-09-22T11:27:13.655590711Z -- add_index(:collections, :name_lower)
2025-09-22T11:27:13.655598687Z    -> 0.0001s
2025-09-22T11:27:13.655606643Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1875s) =============
2025-09-22T11:27:13.655614759Z 
2025-09-22T11:27:13.655622565Z Migrating to AddKeypairToActors (20240926162407)
2025-09-22T11:27:13.655630762Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-09-22T11:27:13.655639349Z -- change_table(:federails_actors)
2025-09-22T11:27:13.655647245Z    -> 0.0016s
2025-09-22T11:27:13.655655131Z == 20240926162407 AddKeypairToActors: migrated (0.0016s) ======================
2025-09-22T11:27:13.655663167Z 
2025-09-22T11:27:13.655670922Z Migrating to AddUuids (20241004194445)
2025-09-22T11:27:13.655678818Z == 20241004194445 AddUuids: migrating =========================================
2025-09-22T11:27:13.655686834Z -- change_table(:federails_actors)
2025-09-22T11:27:13.655694720Z    -> 0.0041s
2025-09-22T11:27:13.655702706Z -- change_table(:federails_activities)
2025-09-22T11:27:13.655710612Z    -> 0.0009s
2025-09-22T11:27:13.655718498Z -- change_table(:federails_followings)
2025-09-22T11:27:13.655726394Z    -> 0.0009s
2025-09-22T11:27:13.655734310Z == 20241004194445 AddUuids: migrated (0.0060s) ================================
2025-09-22T11:27:13.655742416Z 
2025-09-22T11:27:13.655750182Z Migrating to CreateComments (20241007182824)
2025-09-22T11:27:13.655758128Z == 20241007182824 CreateComments: migrating ===================================
2025-09-22T11:27:13.655766334Z -- create_table(:comments)
2025-09-22T11:27:13.655783800Z    -> 0.0024s
2025-09-22T11:27:13.655791796Z == 20241007182824 CreateComments: migrated (0.0025s) ==========================
2025-09-22T11:27:13.655799882Z 
2025-09-22T11:27:13.655807628Z Migrating to AddSystemToComments (20241009122540)
2025-09-22T11:27:13.655815564Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-09-22T11:27:13.655823600Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-09-22T11:27:13.655831746Z    -> 0.0010s
2025-09-22T11:27:13.655840023Z == 20241009122540 AddSystemToComments: migrated (0.0012s) =====================
2025-09-22T11:27:13.655864672Z 
2025-09-22T11:27:13.655875504Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-09-22T11:27:13.655883611Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-09-22T11:27:13.655893901Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0017s) ============
2025-09-22T11:27:13.655902008Z 
2025-09-22T11:27:13.655909913Z Migrating to AddOmniauthToUsers (20241015090803)
2025-09-22T11:27:13.655918050Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-09-22T11:27:13.655926196Z -- add_column(:users, :auth_provider, :string)
2025-09-22T11:27:13.655934152Z    -> 0.0009s
2025-09-22T11:27:13.655942068Z -- add_column(:users, :auth_uid, :string)
2025-09-22T11:27:13.655950645Z    -> 0.0008s
2025-09-22T11:27:13.655958601Z == 20241015090803 AddOmniauthToUsers: migrated (0.0017s) ======================
2025-09-22T11:27:13.655966658Z 
2025-09-22T11:27:13.655974363Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-09-22T11:27:13.655982359Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-09-22T11:27:13.655990616Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-09-22T11:27:13.655998842Z    -> 0.0009s
2025-09-22T11:27:13.656006698Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-09-22T11:27:13.656014744Z    -> 0.0008s
2025-09-22T11:27:13.656022620Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0017s) =====
2025-09-22T11:27:13.656030677Z 
2025-09-22T11:27:13.656038392Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-09-22T11:27:13.656046368Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-09-22T11:27:13.656054434Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-09-22T11:27:13.656062481Z    -> 0.0011s
2025-09-22T11:27:13.656070336Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0011s) ======
2025-09-22T11:27:13.656087982Z 
2025-09-22T11:27:13.656095788Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-09-22T11:27:13.656103754Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-09-22T11:27:13.656112331Z -- change_table(:users)
2025-09-22T11:27:13.656120227Z    -> 0.0012s
2025-09-22T11:27:13.656128183Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0012s) =====================
2025-09-22T11:27:13.656136209Z 
2025-09-22T11:27:13.656143935Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-09-22T11:27:13.656152091Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-09-22T11:27:13.656160277Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0068s) =================
2025-09-22T11:27:13.656168344Z 
2025-09-22T11:27:13.656176049Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-09-22T11:27:13.656184015Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-09-22T11:27:13.656192963Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-09-22T11:27:13.656204336Z    -> 0.0010s
2025-09-22T11:27:13.656214416Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-09-22T11:27:13.656222954Z    -> 0.0014s
2025-09-22T11:27:13.656231030Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-09-22T11:27:13.656239427Z    -> 0.0005s
2025-09-22T11:27:13.656247974Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-09-22T11:27:13.656256862Z    -> 0.0010s
2025-09-22T11:27:13.656265499Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-09-22T11:27:13.656274067Z    -> 0.0009s
2025-09-22T11:27:13.656284407Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-09-22T11:27:13.656295109Z    -> 0.0008s
2025-09-22T11:27:13.656304838Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-09-22T11:27:13.656313596Z    -> 0.0007s
2025-09-22T11:27:13.656321652Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0063s) ===================
2025-09-22T11:27:13.656330039Z 
2025-09-22T11:27:13.656338035Z Migrating to AddInProgressToProblems (20241105121830)
2025-09-22T11:27:13.656346492Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-09-22T11:27:13.656354699Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-09-22T11:27:13.656364018Z    -> 0.0012s
2025-09-22T11:27:13.656373938Z == 20241105121830 AddInProgressToProblems: migrated (0.0013s) =================
2025-09-22T11:27:13.656394118Z 
2025-09-22T11:27:13.656402144Z Migrating to ClearStuckProblems (20241118155027)
2025-09-22T11:27:13.656410150Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-09-22T11:27:13.656418327Z == 20241118155027 ClearStuckProblems: migrated (0.0287s) ======================
2025-09-22T11:27:13.656426393Z 
2025-09-22T11:27:13.656434149Z Migrating to AddApprovedToUser (20241122121621)
2025-09-22T11:27:13.656442155Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-09-22T11:27:13.656450331Z -- change_table(:users)
2025-09-22T11:27:13.656458478Z    -> 0.0017s
2025-09-22T11:27:13.656466384Z == 20241122121621 AddApprovedToUser: migrated (0.0017s) =======================
2025-09-22T11:27:13.656474410Z 
2025-09-22T11:27:13.656482696Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-09-22T11:27:13.656490733Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-09-22T11:27:13.656498809Z -- create_table(:federails_moderation_reports)
2025-09-22T11:27:13.656506805Z    -> 0.0033s
2025-09-22T11:27:13.656514721Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0033s) ========
2025-09-22T11:27:13.656522807Z 
2025-09-22T11:27:13.656530573Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-09-22T11:27:13.656538679Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-09-22T11:27:13.656546816Z -- create_table(:federails_moderation_domain_blocks)
2025-09-22T11:27:13.656554852Z    -> 0.0006s
2025-09-22T11:27:13.656562808Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0006s) ===
2025-09-22T11:27:13.656570874Z 
2025-09-22T11:27:13.656578620Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-09-22T11:27:13.656586646Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-09-22T11:27:13.656594712Z -- change_column_null(:comments, :commenter_id, true)
2025-09-22T11:27:13.656602708Z    -> 0.0090s
2025-09-22T11:27:13.656610704Z -- change_column_null(:comments, :commenter_type, true)
2025-09-22T11:27:13.656618730Z    -> 0.0078s
2025-09-22T11:27:13.656626666Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-09-22T11:27:13.656634773Z    -> 0.0009s
2025-09-22T11:27:13.656642709Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-09-22T11:27:13.656650825Z    -> 0.0118s
2025-09-22T11:27:14.519256596Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0313s) =======
2025-09-22T11:27:14.519343701Z 
2025-09-22T11:27:14.519354292Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-09-22T11:27:14.519363070Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-09-22T11:27:14.519371417Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-09-22T11:27:14.519381467Z    -> 0.0011s
2025-09-22T11:27:14.519392008Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0011s) =================
2025-09-22T11:27:14.519403020Z 
2025-09-22T11:27:14.519412870Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-09-22T11:27:14.519423441Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-09-22T11:27:14.519434363Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1821s) ==================
2025-09-22T11:27:14.519444995Z 
2025-09-22T11:27:14.519455476Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-09-22T11:27:14.519465757Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-09-22T11:27:14.519476338Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-09-22T11:27:14.519488663Z    -> 0.0019s
2025-09-22T11:27:14.519501990Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0019s) ==========
2025-09-22T11:27:14.519515467Z 
2025-09-22T11:27:14.519528052Z Migrating to AddCreatorToCollections (20250222000000)
2025-09-22T11:27:14.519538954Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-09-22T11:27:14.519549345Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-09-22T11:27:14.519559886Z    -> 0.0253s
2025-09-22T11:27:14.519569646Z == 20250222000000 AddCreatorToCollections: migrated (0.0253s) =================
2025-09-22T11:27:14.519579736Z 
2025-09-22T11:27:14.519592201Z Migrating to AddLocalToActors (20250305171530)
2025-09-22T11:27:14.519602191Z == 20250305171530 AddLocalToActors: migrating =================================
2025-09-22T11:27:14.519611761Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-09-22T11:27:14.519621139Z    -> 0.0011s
2025-09-22T11:27:14.519630178Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-09-22T11:27:14.519639767Z    -> 0.0019s
2025-09-22T11:27:14.519648675Z    -> 0 rows
2025-09-22T11:27:14.519658715Z == 20250305171530 AddLocalToActors: migrated (0.0062s) ========================
2025-09-22T11:27:14.519668815Z 
2025-09-22T11:27:14.519679016Z Migrating to AddActorTypeToActors (20250407160721)
2025-09-22T11:27:14.519689176Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-09-22T11:27:14.519714888Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-09-22T11:27:14.519725600Z    -> 0.0010s
2025-09-22T11:27:14.519735951Z == 20250407160721 AddActorTypeToActors: migrated (0.0010s) ====================
2025-09-22T11:27:14.519746341Z 
2025-09-22T11:27:14.519756241Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-09-22T11:27:14.519766712Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-09-22T11:27:14.519779017Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-09-22T11:27:14.519789859Z    -> 0.0015s
2025-09-22T11:27:14.519799809Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0016s) =================
2025-09-22T11:27:14.519810030Z 
2025-09-22T11:27:14.519820401Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-09-22T11:27:14.519828797Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-09-22T11:27:14.519836874Z -- create_table(:oauth_applications)
2025-09-22T11:27:14.519863718Z    -> 0.0005s
2025-09-22T11:27:14.519878337Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-09-22T11:27:14.519889199Z    -> 0.0002s
2025-09-22T11:27:14.519899790Z -- create_table(:oauth_access_grants)
2025-09-22T11:27:14.519910031Z    -> 0.0006s
2025-09-22T11:27:14.519918217Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-09-22T11:27:14.519926564Z    -> 0.0001s
2025-09-22T11:27:14.519934490Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-09-22T11:27:14.519942647Z    -> 0.0083s
2025-09-22T11:27:14.519950633Z -- create_table(:oauth_access_tokens)
2025-09-22T11:27:14.519958519Z    -> 0.0015s
2025-09-22T11:27:14.519967346Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-09-22T11:27:14.519975423Z    -> 0.0001s
2025-09-22T11:27:14.519983329Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-09-22T11:27:14.519991305Z    -> 0.0001s
2025-09-22T11:27:14.519999190Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-09-22T11:27:14.520007297Z    -> 0.0098s
2025-09-22T11:27:14.520015243Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-09-22T11:27:14.520023269Z    -> 0.0080s
2025-09-22T11:27:14.520031155Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-09-22T11:27:14.520039311Z    -> 0.0100s
2025-09-22T11:27:14.520047087Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0397s) ==================
2025-09-22T11:27:14.520055103Z 
2025-09-22T11:27:14.520075534Z Migrating to AddOwnerToApplication (20250408145956)
2025-09-22T11:27:14.520083620Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-09-22T11:27:14.520091777Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-09-22T11:27:14.520099753Z    -> 0.0011s
2025-09-22T11:27:14.520107609Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-09-22T11:27:14.520115595Z    -> 0.0008s
2025-09-22T11:27:14.520123471Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-09-22T11:27:14.520132469Z    -> 0.0002s
2025-09-22T11:27:14.520142349Z == 20250408145956 AddOwnerToApplication: migrated (0.0073s) ===================
2025-09-22T11:27:14.520152700Z 
2025-09-22T11:27:14.520163692Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-09-22T11:27:14.520176057Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-09-22T11:27:14.520188181Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-09-22T11:27:14.520199444Z    -> 0.0115s
2025-09-22T11:27:14.520210716Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0131s) ============
2025-09-22T11:27:14.520222179Z 
2025-09-22T11:27:14.520232149Z Migrating to AddQuotaToUsers (20250409125753)
2025-09-22T11:27:14.520243763Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-09-22T11:27:14.520254585Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-09-22T11:27:14.520264645Z    -> 0.0010s
2025-09-22T11:27:14.520274455Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-09-22T11:27:14.520284976Z    -> 0.0009s
2025-09-22T11:27:14.520294535Z == 20250409125753 AddQuotaToUsers: migrated (0.0034s) =========================
2025-09-22T11:27:14.520303734Z 
2025-09-22T11:27:14.520312341Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-09-22T11:27:14.520321730Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-09-22T11:27:14.520331119Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-09-22T11:27:14.520341890Z    -> 0.0121s
2025-09-22T11:27:14.520352572Z -- add_index(:model_files, :filename_lower)
2025-09-22T11:27:14.520363023Z    -> 0.0002s
2025-09-22T11:27:14.520373384Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0137s) 
2025-09-22T11:27:14.520385248Z 
2025-09-22T11:27:14.520395749Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-09-22T11:27:14.520406591Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-09-22T11:27:14.520431691Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-09-22T11:27:14.520440399Z    -> 0.0002s
2025-09-22T11:27:14.520448555Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0012s) ===================
2025-09-22T11:27:14.520456792Z 
2025-09-22T11:27:14.520464768Z Migrating to AddPreviewToModelFile (20250520111046)
2025-09-22T11:27:14.520472814Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-09-22T11:27:14.520481051Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-09-22T11:27:14.520489107Z    -> 0.0011s
2025-09-22T11:27:14.520497083Z == 20250520111046 AddPreviewToModelFile: migrated (0.0020s) ===================
2025-09-22T11:27:14.520505089Z 
2025-09-22T11:27:14.520512784Z Migrating to CreateAltchaSolutions (20250609210440)
2025-09-22T11:27:14.520520720Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-09-22T11:27:14.520528937Z -- create_table(:altcha_solutions)
2025-09-22T11:27:14.520536923Z    -> 0.0004s
2025-09-22T11:27:14.520545039Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-09-22T11:27:14.520553526Z    -> 0.0002s
2025-09-22T11:27:14.520561432Z == 20250609210440 CreateAltchaSolutions: migrated (0.0017s) ===================
2025-09-22T11:27:14.520569428Z 
2025-09-22T11:27:14.520577124Z Migrating to AddIndexableFields (20250620141805)
2025-09-22T11:27:14.520585060Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-09-22T11:27:14.520593156Z -- change_table(:models)
2025-09-22T11:27:14.520601022Z    -> 0.0025s
2025-09-22T11:27:14.520608878Z -- change_table(:creators)
2025-09-22T11:27:14.520616764Z    -> 0.0019s
2025-09-22T11:27:14.520624740Z -- change_table(:collections)
2025-09-22T11:27:14.520632606Z    -> 0.0017s
2025-09-22T11:27:14.520642526Z == 20250620141805 AddIndexableFields: migrated (0.0061s) ======================
2025-09-22T11:27:14.520650642Z 
2025-09-22T11:27:14.520659560Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-09-22T11:27:14.520667636Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-09-22T11:27:14.520675722Z -- change_column(:models, :indexable, :string)
2025-09-22T11:27:14.520683739Z    -> 0.0277s
2025-09-22T11:27:14.520691705Z -- change_column(:models, :ai_indexable, :string)
2025-09-22T11:27:14.520699681Z    -> 0.0178s
2025-09-22T11:27:14.520707797Z -- change_column(:creators, :indexable, :string)
2025-09-22T11:27:14.520715733Z    -> 0.0089s
2025-09-22T11:27:14.520735343Z -- change_column(:creators, :ai_indexable, :string)
2025-09-22T11:27:14.520743459Z    -> 0.0089s
2025-09-22T11:27:14.520751385Z -- change_column(:collections, :indexable, :string)
2025-09-22T11:27:14.520759401Z    -> 0.0540s
2025-09-22T11:27:14.520767397Z -- change_column(:collections, :ai_indexable, :string)
2025-09-22T11:27:14.520775423Z    -> 0.0205s
2025-09-22T11:27:14.520783459Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1385s) ======
2025-09-22T11:27:14.520791816Z 
2025-09-22T11:27:14.520799712Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-09-22T11:27:14.520807708Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-09-22T11:27:14.520815784Z -- change_table(:models)
2025-09-22T11:27:14.520823660Z    -> 0.0004s
2025-09-22T11:27:14.520831626Z -- change_table(:creators)
2025-09-22T11:27:14.520839492Z    -> 0.0003s
2025-09-22T11:27:14.520848821Z -- change_table(:collections)
2025-09-22T11:27:14.520856957Z    -> 0.0003s
2025-09-22T11:27:14.520864873Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0009s) =================
2025-09-22T11:27:14.520873350Z 
2025-09-22T11:27:14.520883030Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-09-22T11:27:14.520893070Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-09-22T11:27:14.520903241Z -- change_table(:links)
2025-09-22T11:27:14.520912078Z    -> 0.0002s
2025-09-22T11:27:14.520919984Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-09-22T11:27:14.520928081Z 
2025-09-22T11:27:14.520935876Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-09-22T11:27:14.520945255Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-09-22T11:27:14.520955426Z -- add_column(:links, :synced_at, :datetime)
2025-09-22T11:27:14.520965626Z    -> 0.0010s
2025-09-22T11:27:14.520975777Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0010s) ======================
2025-09-22T11:27:14.520986167Z 
2025-09-22T11:27:14.520996087Z Migrating to CreateFaspClientProviders (20250806142734)
2025-09-22T11:27:14.521004454Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-09-22T11:27:14.521013713Z -- create_table(:fasp_client_providers)
2025-09-22T11:27:14.521023964Z    -> 0.0463s
2025-09-22T11:27:14.521034234Z == 20250806142734 CreateFaspClientProviders: migrated (0.0464s) ===============
2025-09-22T11:27:14.521044966Z 
2025-09-22T11:27:14.521054746Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-09-22T11:27:14.521447045Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-09-22T11:27:14.521461755Z -- create_table(:fasp_client_event_subscriptions)
2025-09-22T11:27:14.521471965Z    -> 0.0135s
2025-09-22T11:27:14.521481805Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0135s) ======
2025-09-22T11:27:14.521490843Z 
2025-09-22T11:27:14.521499501Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-09-22T11:27:14.543182461Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-09-22T11:27:14.543224335Z -- create_table(:fasp_client_backfill_requests)
2025-09-22T11:27:14.543240077Z    -> 0.0056s
2025-09-22T11:27:14.543252071Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0056s) ========
2025-09-22T11:27:14.543262512Z 
2025-09-22T11:27:14.597232057Z s6-rc: info: service init-manyfold-config successfully started
2025-09-22T11:27:14.597433322Z s6-rc: info: service init-config-end: starting
2025-09-22T11:27:14.599543611Z s6-rc: info: service init-config-end successfully started
2025-09-22T11:27:14.599758864Z s6-rc: info: service init-mods: starting
2025-09-22T11:27:14.601811256Z s6-rc: info: service init-mods successfully started
2025-09-22T11:27:14.602030798Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-09-22T11:27:14.609912684Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-09-22T11:27:14.610095973Z s6-rc: info: service init-mods-package-install: starting
2025-09-22T11:27:14.621198183Z [pkg-install-init] **** Installing all mod packages ****
2025-09-22T11:27:14.629450055Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-09-22T11:27:14.693221743Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-09-22T11:27:15.018540769Z (1/1) Installing redis (8.0.3-r0)
2025-09-22T11:27:15.038082177Z Executing redis-8.0.3-r0.pre-install
2025-09-22T11:27:15.076004759Z Executing redis-8.0.3-r0.post-install
2025-09-22T11:27:15.084614421Z Executing busybox-1.37.0-r19.trigger
2025-09-22T11:27:15.097175387Z OK: 427 MiB in 116 packages
2025-09-22T11:27:15.187288483Z s6-rc: info: service init-mods-package-install successfully started
2025-09-22T11:27:15.187459587Z s6-rc: info: service init-mods-end: starting
2025-09-22T11:27:15.188892041Z s6-rc: info: service init-mods-end successfully started
2025-09-22T11:27:15.189047614Z s6-rc: info: service init-custom-files: starting
2025-09-22T11:27:15.195010308Z [custom-init] No custom files found, skipping...
2025-09-22T11:27:15.195724155Z s6-rc: info: service init-custom-files successfully started
2025-09-22T11:27:15.195891602Z s6-rc: info: service init-services: starting
2025-09-22T11:27:15.198029876Z s6-rc: info: service init-services successfully started
2025-09-22T11:27:15.198324700Z s6-rc: info: service svc-mod-universal-redis: starting
2025-09-22T11:27:15.198499862Z s6-rc: info: service svc-manyfold: starting
2025-09-22T11:27:15.198708873Z s6-rc: info: service svc-cron: starting
2025-09-22T11:27:15.201218275Z s6-rc: info: service svc-cron successfully started
2025-09-22T11:27:15.201470342Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-09-22T11:27:15.211546807Z 283:C 22 Sep 2025 11:27:15.211 # 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-09-22T11:27:15.211581487Z 283:C 22 Sep 2025 11:27:15.211 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-09-22T11:27:15.211586126Z 283:C 22 Sep 2025 11:27:15.211 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=283, just started
2025-09-22T11:27:15.211590295Z 283:C 22 Sep 2025 11:27:15.211 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-09-22T11:27:15.212277989Z 283:M 22 Sep 2025 11:27:15.212 * monotonic clock: POSIX clock_gettime
2025-09-22T11:27:15.212685930Z 283:M 22 Sep 2025 11:27:15.212 * Running mode=standalone, port=6379.
2025-09-22T11:27:15.213000914Z 283:M 22 Sep 2025 11:27:15.212 * Server initialized
2025-09-22T11:27:15.213028500Z 283:M 22 Sep 2025 11:27:15.213 * Ready to accept connections tcp
2025-09-22T11:27:15.355786304Z 11:27:15 rails.1              | started with pid 301
2025-09-22T11:27:15.355811775Z 11:27:15 default_worker.1     | started with pid 302
2025-09-22T11:27:15.355870303Z 11:27:15 performance_worker.1 | started with pid 303
2025-09-22T11:27:16.578869008Z 11:27:16 rails.1              | `/root` is not writable.
2025-09-22T11:27:16.578906654Z 11:27:16 rails.1              | Bundler will use `/tmp/bundler20250922-301-guzkpq301' as your home directory temporarily.
2025-09-22T11:27:17.088327303Z 11:27:17 default_worker.1     | `/root` is not writable.
2025-09-22T11:27:17.088362093Z 11:27:17 default_worker.1     | Bundler will use `/tmp/bundler20250922-302-2wppm7302' as your home directory temporarily.
2025-09-22T11:27:17.091696956Z 11:27:17 performance_worker.1 | `/root` is not writable.
2025-09-22T11:27:17.091725604Z 11:27:17 performance_worker.1 | Bundler will use `/tmp/bundler20250922-303-guq38a303' as your home directory temporarily.
2025-09-22T11:27:17.589994454Z 11:27:17 rails.1              | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-22T11:27:17.590021578Z 11:27:17 rails.1              | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T11:27:17.590090016Z 11:27:17 rails.1              | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T11:27:17.957016943Z 11:27:17 rails.1              | => Booting Puma
2025-09-22T11:27:17.957057906Z 11:27:17 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-09-22T11:27:17.957066744Z 11:27:17 rails.1              | => Run `bin/rails server --help` for more startup options
2025-09-22T11:27:18.099694957Z 11:27:18 performance_worker.1 | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-22T11:27:18.099718484Z 11:27:18 performance_worker.1 | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T11:27:18.099785379Z 11:27:18 performance_worker.1 | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T11:27:18.109910612Z 11:27:18 default_worker.1     | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-22T11:27:18.109924911Z 11:27:18 default_worker.1     | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T11:27:18.110078600Z 11:27:18 default_worker.1     | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T11:27:18.563172499Z 11:27:18 performance_worker.1 | Server: f773de2cf7ef, Context: rails, Role: web, data: {cpu: {one_min: 6.39, five_min: 4.76, fifteen_min: 4.74}, memory: 0.187252736e9, disk: {available: 814788820992, total: 938656133120, used: 123867312128}}
2025-09-22T11:27:18.583745825Z 11:27:18 default_worker.1     | Server: f773de2cf7ef, Context: rails, Role: web, data: {cpu: {one_min: 6.39, five_min: 4.76, fifteen_min: 4.74}, memory: 0.178008064e9, disk: {available: 814788714496, total: 938656133120, used: 123867418624}}
2025-09-22T11:27:20.555274472Z 11:27:20 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:20.557094616Z 11:27:20 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:20.557171922Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.556Z pid=303 tid=23z: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T11:27:20.558121443Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.557Z pid=302 tid=23y: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T11:27:20.563240208Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.562Z pid=303 tid=23z: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-22T11:27:20.563696998Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.563Z pid=302 tid=23y: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-22T11:27:20.565555258Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.565Z pid=303 tid=23z: Cron Jobs - added job with name clear-downloads in the namespace default
2025-09-22T11:27:20.633673136Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.633Z pid=302 tid=23y: Booted Rails 8.0.2.1 application in production environment
2025-09-22T11:27:20.633700150Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.633Z pid=302 tid=23y: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-22T11:27:20.633733547Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.633Z pid=302 tid=23y: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-22T11:27:20.633794640Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.633Z pid=302 tid=23y: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-22T11:27:20.636174531Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.635Z pid=303 tid=23z: Booted Rails 8.0.2.1 application in production environment
2025-09-22T11:27:20.636216606Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.635Z pid=302 tid=23y: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-09-22T11:27:20.636233280Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.635Z pid=303 tid=23z: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-22T11:27:20.636286337Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.636Z pid=303 tid=23z: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-22T11:27:20.636326006Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.636Z pid=303 tid=23z: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-22T11:27:20.639528613Z 11:27:20 performance_worker.1 | INFO  2025-09-22T11:27:20.639Z pid=303 tid=23z: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-09-22T11:27:20.735163836Z 11:27:20 rails.1              | Server: f773de2cf7ef, Context: rails, Role: web, data: {cpu: {one_min: 6.39, five_min: 4.76, fifteen_min: 4.74}, memory: 0.170278912e9, disk: {available: 814792372224, total: 938656133120, used: 123863760896}}
2025-09-22T11:27:20.735189017Z 11:27:20 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:20.735198606Z 11:27:20 rails.1              | INFO  2025-09-22T11:27:20.557Z pid=301 tid=2cd: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T11:27:20.735255801Z 11:27:20 rails.1              | INFO  2025-09-22T11:27:20.562Z pid=301 tid=2cd: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-22T11:27:20.735288697Z 11:27:20 rails.1              | INFO  2025-09-22T11:27:20.565Z pid=301 tid=2cd: Cron Jobs - added job with name clear-downloads in the namespace default
2025-09-22T11:27:20.735299208Z 11:27:20 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 8924a63c-70a1-4b86-8b76-0479a13bdbbb) to Sidekiq(upgrade)
2025-09-22T11:27:20.735327916Z 11:27:20 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 3221aa12-01b1-41f3-bf56-9f798d510653) to Sidekiq(upgrade)
2025-09-22T11:27:20.735342846Z 11:27:20 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: c0f6cbf8-006c-4ee8-8ccf-27475a5ade43) to Sidekiq(upgrade)
2025-09-22T11:27:20.735352255Z 11:27:20 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: ba403cfd-45a3-42db-996b-c8ee9a2c3dc8) to Sidekiq(upgrade)
2025-09-22T11:27:20.735360782Z 11:27:20 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: c54a107d-96c4-47e7-8dc5-88e864ae60ad) to Sidekiq(upgrade)
2025-09-22T11:27:20.735375051Z 11:27:20 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: cf3e716c-d2cc-4313-a366-24ef0171fa86) to Sidekiq(upgrade)
2025-09-22T11:27:20.735383789Z 11:27:20 rails.1              | [301] Puma starting in cluster mode...
2025-09-22T11:27:20.735416344Z 11:27:20 rails.1              | [301] * Puma version: 7.0.3 ("Romantic Warrior")
2025-09-22T11:27:20.735439311Z 11:27:20 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-22T11:27:20.735451766Z 11:27:20 rails.1              | [301] *  Min threads: 4
2025-09-22T11:27:20.735483029Z 11:27:20 rails.1              | [301] *  Max threads: 16
2025-09-22T11:27:20.735494882Z 11:27:20 rails.1              | [301] *  Environment: production
2025-09-22T11:27:20.735504802Z 11:27:20 rails.1              | [301] *   Master PID: 301
2025-09-22T11:27:20.735541246Z 11:27:20 rails.1              | [301] *      Workers: 4
2025-09-22T11:27:20.735563110Z 11:27:20 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-09-22T11:27:20.735593561Z 11:27:20 rails.1              | [301] * Preloading application
2025-09-22T11:27:20.735613030Z 11:27:20 rails.1              | [301] * Listening on http://[::]:3214
2025-09-22T11:27:20.735641027Z 11:27:20 rails.1              | [301] Use Ctrl-C to stop
2025-09-22T11:27:20.759923910Z 11:27:20 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-09-22T11:27:20.760150496Z 11:27:20 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.02s, phase: 0
2025-09-22T11:27:20.760191118Z 11:27:20 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-09-22T11:27:20.761996292Z 11:27:20 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-09-22T11:27:20.896929074Z 11:27:20 default_worker.1     | Server: f773de2cf7ef, Context: sidekiq, Role: background, data: {cpu: {one_min: 6.39, five_min: 4.76, fifteen_min: 4.74}, memory: 0.222552064e9, disk: {available: 814765600768, total: 938656133120, used: 123890532352}}
2025-09-22T11:27:20.900643271Z 11:27:20 performance_worker.1 | Server: f773de2cf7ef, Context: sidekiq, Role: background, data: {cpu: {one_min: 6.39, five_min: 4.76, fifteen_min: 4.74}, memory: 0.224997376e9, disk: {available: 814765588480, total: 938656133120, used: 123890544640}}
2025-09-22T11:27:20.949041191Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.897Z pid=302 tid=h0m jid=059ac6678eb6a2358925aa9d class=Upgrade::FixNilFileSizeValues: start
2025-09-22T11:27:20.955828584Z 11:27:20 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [8924a63c-70a1-4b86-8b76-0479a13bdbbb] Performing Upgrade::FixNilFileSizeValues (Job ID: 8924a63c-70a1-4b86-8b76-0479a13bdbbb) from Sidekiq(upgrade) enqueued at 2025-09-22T11:27:20.579137450Z
2025-09-22T11:27:20.956838567Z 11:27:20 default_worker.1     | INFO  2025-09-22T11:27:20.955Z pid=302 tid=h2e jid=8f317f9899786aba0e10635f class=Upgrade::UpdateActorsJob: start
2025-09-22T11:27:20.961043262Z 11:27:20 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [ba403cfd-45a3-42db-996b-c8ee9a2c3dc8] Performing Upgrade::UpdateActorsJob (Job ID: ba403cfd-45a3-42db-996b-c8ee9a2c3dc8) from Sidekiq(upgrade) enqueued at 2025-09-22T11:27:20.582409167Z
2025-09-22T11:27:21.001057213Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:20.948Z pid=302 tid=h12 jid=7e85c5134cc2dffcddfb107a class=Upgrade::DisambiguateUsernamesJob: start
2025-09-22T11:27:21.001788265Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [c0f6cbf8-006c-4ee8-8ccf-27475a5ade43] Performing Upgrade::DisambiguateUsernamesJob (Job ID: c0f6cbf8-006c-4ee8-8ccf-27475a5ade43) from Sidekiq(upgrade) enqueued at 2025-09-22T11:27:20.581696212Z
2025-09-22T11:27:21.002903710Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:20.948Z pid=302 tid=h1a jid=5c9032cdb7a7c3382b96667f class=Upgrade::BackfillDataPackages: start
2025-09-22T11:27:21.008153489Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [3221aa12-01b1-41f3-bf56-9f798d510653] Performing Upgrade::BackfillDataPackages (Job ID: 3221aa12-01b1-41f3-bf56-9f798d510653) from Sidekiq(upgrade) enqueued at 2025-09-22T11:27:20.580883546Z
2025-09-22T11:27:21.017143667Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [3221aa12-01b1-41f3-bf56-9f798d510653] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:21.020834607Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [ba403cfd-45a3-42db-996b-c8ee9a2c3dc8] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:21.073309284Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [c0f6cbf8-006c-4ee8-8ccf-27475a5ade43] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:21.235150575Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-09-22T11:27:21.236111710Z s6-rc: info: service svc-manyfold successfully started
2025-09-22T11:27:21.236311993Z s6-rc: info: service legacy-services: starting
2025-09-22T11:27:21.245632797Z s6-rc: info: service legacy-services successfully started
2025-09-22T11:27:21.245876407Z s6-rc: info: service ci-service-check: starting
2025-09-22T11:27:21.248493736Z [ls.io-init] done.
2025-09-22T11:27:21.249169256Z s6-rc: info: service ci-service-check successfully started
2025-09-22T11:27:21.307415481Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [8924a63c-70a1-4b86-8b76-0479a13bdbbb] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:21.349870296Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [8924a63c-70a1-4b86-8b76-0479a13bdbbb] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-22T11:27:21.359201481Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [8924a63c-70a1-4b86-8b76-0479a13bdbbb] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.032
2025-09-22T11:27:21.362415491Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [3221aa12-01b1-41f3-bf56-9f798d510653] Performed Upgrade::BackfillDataPackages (Job ID: 3221aa12-01b1-41f3-bf56-9f798d510653) from Sidekiq(upgrade) in 353.82ms
2025-09-22T11:27:21.364904812Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [c0f6cbf8-006c-4ee8-8ccf-27475a5ade43] Performed Upgrade::DisambiguateUsernamesJob (Job ID: c0f6cbf8-006c-4ee8-8ccf-27475a5ade43) from Sidekiq(upgrade) in 363.08ms
2025-09-22T11:27:21.366918316Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.365Z pid=302 tid=h1a jid=5c9032cdb7a7c3382b96667f class=Upgrade::BackfillDataPackages elapsed=0.416: done
2025-09-22T11:27:21.367173670Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [ba403cfd-45a3-42db-996b-c8ee9a2c3dc8] Performed Upgrade::UpdateActorsJob (Job ID: ba403cfd-45a3-42db-996b-c8ee9a2c3dc8) from Sidekiq(upgrade) in 403.58ms
2025-09-22T11:27:21.368882209Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [8924a63c-70a1-4b86-8b76-0479a13bdbbb] Performed Upgrade::FixNilFileSizeValues (Job ID: 8924a63c-70a1-4b86-8b76-0479a13bdbbb) from Sidekiq(upgrade) in 413.21ms
2025-09-22T11:27:21.375010957Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.366Z pid=302 tid=h12 jid=7e85c5134cc2dffcddfb107a class=Upgrade::DisambiguateUsernamesJob elapsed=0.418: done
2025-09-22T11:27:21.375077822Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.368Z pid=302 tid=h1a jid=3af6051f54a368cf25fca6b3 class=Upgrade::FixParentCollections: start
2025-09-22T11:27:21.375899345Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [c54a107d-96c4-47e7-8dc5-88e864ae60ad] Performing Upgrade::FixParentCollections (Job ID: c54a107d-96c4-47e7-8dc5-88e864ae60ad) from Sidekiq(upgrade) enqueued at 2025-09-22T11:27:20.583119306Z
2025-09-22T11:27:21.376483401Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.375Z pid=302 tid=h12 jid=a9570cd4b0e8d7bfa4730e4e class=Upgrade::PruneOrphanedProblems: start
2025-09-22T11:27:21.376838636Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [cf3e716c-d2cc-4313-a366-24ef0171fa86] Performing Upgrade::PruneOrphanedProblems (Job ID: cf3e716c-d2cc-4313-a366-24ef0171fa86) from Sidekiq(upgrade) enqueued at 2025-09-22T11:27:20.584031583Z
2025-09-22T11:27:21.377505098Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.375Z pid=302 tid=h0m jid=059ac6678eb6a2358925aa9d class=Upgrade::FixNilFileSizeValues elapsed=0.478: done
2025-09-22T11:27:21.378358045Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [c54a107d-96c4-47e7-8dc5-88e864ae60ad] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:21.442289365Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.374Z pid=302 tid=h2e jid=8f317f9899786aba0e10635f class=Upgrade::UpdateActorsJob elapsed=0.419: done
2025-09-22T11:27:21.505354821Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [cf3e716c-d2cc-4313-a366-24ef0171fa86] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T11:27:21.761569766Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [cf3e716c-d2cc-4313-a366-24ef0171fa86] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-22T11:27:21.764831111Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [cf3e716c-d2cc-4313-a366-24ef0171fa86] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.140
2025-09-22T11:27:21.765720572Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [c54a107d-96c4-47e7-8dc5-88e864ae60ad] Performed Upgrade::FixParentCollections (Job ID: c54a107d-96c4-47e7-8dc5-88e864ae60ad) from Sidekiq(upgrade) in 389.84ms
2025-09-22T11:27:21.796027833Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.795Z pid=302 tid=h1a jid=3af6051f54a368cf25fca6b3 class=Upgrade::FixParentCollections elapsed=0.427: done
2025-09-22T11:27:21.797936184Z 11:27:21 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [cf3e716c-d2cc-4313-a366-24ef0171fa86] Performed Upgrade::PruneOrphanedProblems (Job ID: cf3e716c-d2cc-4313-a366-24ef0171fa86) from Sidekiq(upgrade) in 421.18ms
2025-09-22T11:27:21.809303027Z 11:27:21 default_worker.1     | INFO  2025-09-22T11:27:21.809Z pid=302 tid=h12 jid=a9570cd4b0e8d7bfa4730e4e class=Upgrade::PruneOrphanedProblems elapsed=0.433: done
2025-09-22T11:27:45.893351071Z 11:27:45 rails.1              | [78760d72-56d0-4162-a91d-928e93cecd86] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1392,"duration":26.53,"view":0.0,"db":3.85,"@timestamp":"2025-09-22T11:27:45.892Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-22T11:27:46.843809937Z 11:27:46 rails.1              | [21a03678-c1bc-4435-9923-d819ecd0724a] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":74117,"duration":929.11,"view":0.0,"db":26.19,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-22T11:27:46.843Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-22T11:27:46.926321622Z 11:27:46 rails.1              | [a577c9ff-a1a7-4858-9c72-1652732007c7] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1090,"duration":50.78,"view":0.0,"db":3.13,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-22T11:27:46.907Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-22T11:27:47.665067398Z 11:27:47 rails.1              | [86bdbf74-4526-4330-960b-d2e012cb7f5e] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24016,"duration":713.61,"view":588.91,"db":61.81,"@timestamp":"2025-09-22T11:27:47.664Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-09-22T11:27:47.738648274Z 11:27:47 rails.1              | [6588990d-f1a0-4c84-8f79-895135f5f328] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1180,"duration":30.85,"view":0.0,"db":4.31,"@timestamp":"2025-09-22T11:27:47.737Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-22T11:27:48.102609528Z 11:27:48 rails.1              | [191038f4-4053-4cd5-96ab-af64134cf1c8] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14481,"duration":243.72,"view":0.0,"db":2.55,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-22T11:27:48.066Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-22T11:27:48.142851980Z 11:27:48 rails.1              | [7c4dd8d8-8da9-4d80-aa50-0b980686d1a8] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1123,"duration":32.26,"view":0.0,"db":2.94,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-22T11:27:48.142Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-22T11:27:48.557381864Z 11:27:48 rails.1              | [e26c79f7-7e8e-4e0e-bd39-1a5e1265d3ef] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24221,"duration":384.45,"view":193.76,"db":1.6,"@timestamp":"2025-09-22T11:27:48.552Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}