2025-08-25T14:52:52.882828684Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-08-25T14:52:52.882870267Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-08-25T14:52:52.925497310Z [mod-init] Running Docker Modification Logic
2025-08-25T14:52:53.136501771Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-08-25T14:52:55.617083985Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-08-25T14:52:56.028240520Z [mod-init] Installing linuxserver/mods:universal-redis
2025-08-25T14:52:56.053805739Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-08-25T14:52:56.054886696Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-08-25T14:52:56.077966460Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-08-25T14:52:56.081469345Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-08-25T14:52:56.081594917Z s6-rc: info: service fix-attrs: starting
2025-08-25T14:52:56.081821384Z s6-rc: info: service init-migrations: starting
2025-08-25T14:52:56.082016657Z s6-rc: info: service init-envfile: starting
2025-08-25T14:52:56.088316194Z [migrations] started
2025-08-25T14:52:56.088397578Z [migrations] no migrations found
2025-08-25T14:52:56.088894689Z s6-rc: info: service init-migrations successfully started
2025-08-25T14:52:56.089064561Z s6-rc: info: service init-adduser: starting
2025-08-25T14:52:56.089906507Z s6-rc: info: service init-envfile successfully started
2025-08-25T14:52:56.090220009Z s6-rc: info: service fix-attrs successfully started
2025-08-25T14:52:56.090354029Z s6-rc: info: service legacy-cont-init: starting
2025-08-25T14:52:56.096628576Z s6-rc: info: service legacy-cont-init successfully started
2025-08-25T14:52:56.120466837Z usermod: no changes
2025-08-25T14:52:56.128225954Z ───────────────────────────────────────
2025-08-25T14:52:56.128251686Z 
2025-08-25T14:52:56.128258660Z       ██╗     ███████╗██╗ ██████╗
2025-08-25T14:52:56.128265484Z       ██║     ██╔════╝██║██╔═══██╗
2025-08-25T14:52:56.128272237Z       ██║     ███████╗██║██║   ██║
2025-08-25T14:52:56.128280183Z       ██║     ╚════██║██║██║   ██║
2025-08-25T14:52:56.128288260Z       ███████╗███████║██║╚██████╔╝
2025-08-25T14:52:56.128296396Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-08-25T14:52:56.128303751Z 
2025-08-25T14:52:56.128309873Z    Brought to you by linuxserver.io
2025-08-25T14:52:56.128332910Z ───────────────────────────────────────
2025-08-25T14:52:56.128729027Z 
2025-08-25T14:52:56.128757294Z To support LSIO projects visit:
2025-08-25T14:52:56.128767795Z https://www.linuxserver.io/donate/
2025-08-25T14:52:56.128778607Z 
2025-08-25T14:52:56.128788778Z ───────────────────────────────────────
2025-08-25T14:52:56.128800551Z GID/UID
2025-08-25T14:52:56.128811604Z ───────────────────────────────────────
2025-08-25T14:52:56.134110906Z 
2025-08-25T14:52:56.134141849Z User UID:    911
2025-08-25T14:52:56.134151368Z User GID:    911
2025-08-25T14:52:56.134159765Z ───────────────────────────────────────
2025-08-25T14:52:56.136615260Z Linuxserver.io version: v0.122.1-ls100
2025-08-25T14:52:56.137048944Z Build-date: 2025-08-25T14:40:24+00:00
2025-08-25T14:52:56.137077451Z ───────────────────────────────────────
2025-08-25T14:52:56.137091329Z     
2025-08-25T14:52:56.157644975Z s6-rc: info: service init-adduser successfully started
2025-08-25T14:52:56.157724796Z s6-rc: info: service init-device-perms: starting
2025-08-25T14:52:56.165082454Z s6-rc: info: service init-device-perms successfully started
2025-08-25T14:52:56.165214470Z s6-rc: info: service init-os-end: starting
2025-08-25T14:52:56.166583628Z s6-rc: info: service init-os-end successfully started
2025-08-25T14:52:56.166685894Z s6-rc: info: service init-manyfold-config: starting
2025-08-25T14:52:56.166908622Z s6-rc: info: service init-config: starting
2025-08-25T14:52:56.168800653Z s6-rc: info: service init-config successfully started
2025-08-25T14:52:56.169011548Z s6-rc: info: service init-crontab-config: starting
2025-08-25T14:52:56.178985786Z s6-rc: info: service init-crontab-config successfully started
2025-08-25T14:52:56.198698107Z **** Running Manyfold database init. ****
2025-08-25T14:52:58.455447960Z `/root` is not writable.
2025-08-25T14:52:58.455649876Z Bundler will use `/tmp/bundler20250825-173-md244d173' as your home directory temporarily.
2025-08-25T14:53:01.297648103Z /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-08-25T14:53:01.297691831Z You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-25T14:53:01.297701511Z Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-25T14:53:04.993850775Z Server: a6f7bb3b8edc, Context: rails, Role: web, data: {cpu: {one_min: 2.0, five_min: 1.5, fifteen_min: 1.49}, memory: 0.198479872e9, disk: {available: 852105666560, total: 938656133120, used: 86550466560}}
2025-08-25T14:53:04.993903260Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-08-25T14:53:04.993912799Z INFO  2025-08-25T14:53:03.086Z pid=173 tid=29h: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-25T14:53:04.993922198Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-08-25T14:53:04.993931207Z Migrating to CreateLibraries (20210130201037)
2025-08-25T14:53:04.993939293Z == 20210130201037 CreateLibraries: migrating ==================================
2025-08-25T14:53:04.993947429Z -- create_table(:libraries)
2025-08-25T14:53:04.993955205Z    -> 0.0028s
2025-08-25T14:53:04.993963381Z == 20210130201037 CreateLibraries: migrated (0.0028s) =========================
2025-08-25T14:53:04.993971398Z 
2025-08-25T14:53:04.993979143Z Migrating to CreateModels (20210130203243)
2025-08-25T14:53:04.993987049Z == 20210130203243 CreateModels: migrating =====================================
2025-08-25T14:53:04.993995165Z -- create_table(:models)
2025-08-25T14:53:04.994002961Z    -> 0.0021s
2025-08-25T14:53:04.994010777Z == 20210130203243 CreateModels: migrated (0.0021s) ============================
2025-08-25T14:53:04.994018703Z 
2025-08-25T14:53:04.994026418Z Migrating to CreateParts (20210205230918)
2025-08-25T14:53:04.994034234Z == 20210205230918 CreateParts: migrating ======================================
2025-08-25T14:53:04.994042290Z -- create_table(:parts)
2025-08-25T14:53:04.994050166Z    -> 0.0033s
2025-08-25T14:53:04.994058092Z == 20210205230918 CreateParts: migrated (0.0033s) =============================
2025-08-25T14:53:04.994066008Z 
2025-08-25T14:53:04.994073934Z Migrating to AddFieldsToParts (20210210153744)
2025-08-25T14:53:04.994082291Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-08-25T14:53:04.994090818Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-08-25T14:53:04.994099045Z    -> 0.0007s
2025-08-25T14:53:04.994107121Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-08-25T14:53:04.994115067Z    -> 0.0003s
2025-08-25T14:53:04.994122953Z == 20210210153744 AddFieldsToParts: migrated (0.0011s) ========================
2025-08-25T14:53:04.994131209Z 
2025-08-25T14:53:04.994138815Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-08-25T14:53:04.994146811Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-08-25T14:53:04.994183394Z -- create_table(:tags, {id: :integer})
2025-08-25T14:53:04.994191451Z    -> 0.0037s
2025-08-25T14:53:04.994199246Z -- create_table(:taggings, {id: :integer})
2025-08-25T14:53:04.994207182Z    -> 0.0017s
2025-08-25T14:53:04.994215319Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-25T14:53:04.994223495Z    -> 0.0002s
2025-08-25T14:53:04.994232664Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-08-25T14:53:04.994241031Z    -> 0.0020s
2025-08-25T14:53:04.994248806Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0078s) ===============
2025-08-25T14:53:04.994256762Z 
2025-08-25T14:53:04.994264368Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-08-25T14:53:04.994272253Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-08-25T14:53:04.994280640Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-08-25T14:53:04.994288727Z    -> 0.0004s
2025-08-25T14:53:04.994296973Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-25T14:53:04.994305561Z    -> 0.0004s
2025-08-25T14:53:04.994313577Z -- remove_foreign_key(:taggings, :tags)
2025-08-25T14:53:04.994321453Z    -> 0.1639s
2025-08-25T14:53:04.994329399Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-25T14:53:04.994337465Z    -> 0.0143s
2025-08-25T14:53:04.994345982Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-08-25T14:53:04.994354038Z    -> 0.0002s
2025-08-25T14:53:04.994362656Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-08-25T14:53:04.994371273Z    -> 0.0044s
2025-08-25T14:53:04.994379620Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-08-25T14:53:04.994387826Z    -> 0.0685s
2025-08-25T14:53:04.994396033Z == 20210212143002 AddMissingUniqueIndices: migrated (0.2829s) =================
2025-08-25T14:53:04.994404129Z 
2025-08-25T14:53:04.994412356Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-08-25T14:53:04.994420402Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-08-25T14:53:04.994429370Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-08-25T14:53:04.994437566Z    -> 0.0339s
2025-08-25T14:53:04.994445663Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1138s) ===========
2025-08-25T14:53:04.994453609Z 
2025-08-25T14:53:04.994461495Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-08-25T14:53:04.994480363Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-08-25T14:53:04.994488920Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-08-25T14:53:04.994497627Z    -> 0.0003s
2025-08-25T14:53:04.994505443Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-08-25T14:53:04.994514020Z 
2025-08-25T14:53:04.994521736Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-08-25T14:53:04.994529792Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-08-25T14:53:04.994538029Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0006s) ==============
2025-08-25T14:53:04.994546105Z 
2025-08-25T14:53:04.994554552Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-08-25T14:53:04.994562548Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-08-25T14:53:04.994571356Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-25T14:53:04.994579572Z    -> 0.0089s
2025-08-25T14:53:04.994587408Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-25T14:53:04.994595645Z    -> 0.0003s
2025-08-25T14:53:04.994603410Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-08-25T14:53:04.994611467Z    -> 0.0065s
2025-08-25T14:53:04.994619563Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-08-25T14:53:04.994627609Z    -> 0.0014s
2025-08-25T14:53:04.994635325Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-08-25T14:53:04.994643441Z    -> 0.0004s
2025-08-25T14:53:04.994651207Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-08-25T14:53:04.994659223Z    -> 0.0002s
2025-08-25T14:53:04.994667049Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-08-25T14:53:04.994675115Z    -> 0.0037s
2025-08-25T14:53:04.994683271Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-08-25T14:53:04.994691287Z    -> 0.0001s
2025-08-25T14:53:04.994699043Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-08-25T14:53:04.994707049Z    -> 0.0005s
2025-08-25T14:53:04.994714775Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-08-25T14:53:04.994722761Z    -> 0.0001s
2025-08-25T14:53:04.994730557Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-08-25T14:53:04.994738783Z    -> 0.0006s
2025-08-25T14:53:04.994756379Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-08-25T14:53:04.994764675Z    -> 0.0001s
2025-08-25T14:53:04.994772521Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-08-25T14:53:04.994780698Z    -> 0.0014s
2025-08-25T14:53:04.994788503Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-08-25T14:53:04.994796660Z    -> 0.0002s
2025-08-25T14:53:04.994804465Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0249s) =============
2025-08-25T14:53:04.994812411Z 
2025-08-25T14:53:04.994820107Z Migrating to AddPreviewPartToModel (20210220204055)
2025-08-25T14:53:04.994828043Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-08-25T14:53:04.994836069Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-08-25T14:53:04.994844105Z    -> 0.2425s
2025-08-25T14:53:04.994851841Z == 20210220204055 AddPreviewPartToModel: migrated (0.2425s) ===================
2025-08-25T14:53:04.994859727Z 
2025-08-25T14:53:04.994867442Z Migrating to CreateCreators (20210225232756)
2025-08-25T14:53:04.994875278Z == 20210225232756 CreateCreators: migrating ===================================
2025-08-25T14:53:04.994883294Z -- create_table(:creators)
2025-08-25T14:53:04.994891090Z    -> 0.0143s
2025-08-25T14:53:04.994898906Z == 20210225232756 CreateCreators: migrated (0.0143s) ==========================
2025-08-25T14:53:04.994906932Z 
2025-08-25T14:53:04.994915078Z Migrating to AddCreatorToModels (20210225232841)
2025-08-25T14:53:04.994923034Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-08-25T14:53:04.994930950Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-08-25T14:53:04.994938956Z    -> 0.0492s
2025-08-25T14:53:04.994946792Z == 20210225232841 AddCreatorToModels: migrated (0.0493s) ======================
2025-08-25T14:53:04.994955089Z 
2025-08-25T14:53:04.994962724Z Migrating to CreateLinks (20210301230017)
2025-08-25T14:53:04.994970540Z == 20210301230017 CreateLinks: migrating ======================================
2025-08-25T14:53:04.994978466Z -- create_table(:links)
2025-08-25T14:53:04.994986292Z    -> 0.0009s
2025-08-25T14:53:04.994994027Z == 20210301230017 CreateLinks: migrated (0.0009s) =============================
2025-08-25T14:53:04.995001973Z 
2025-08-25T14:53:04.995009979Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-08-25T14:53:04.995018196Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-08-25T14:53:04.995035992Z -- remove_column(:creators, :thingiverse_user, :string)
2025-08-25T14:53:04.995044258Z    -> 0.0644s
2025-08-25T14:53:04.995052475Z -- remove_column(:creators, :cults3d_user, :string)
2025-08-25T14:53:04.995060391Z    -> 0.0049s
2025-08-25T14:53:04.995068177Z -- remove_column(:creators, :mmf_user, :string)
2025-08-25T14:53:04.995076092Z    -> 0.0127s
2025-08-25T14:53:04.995084499Z -- remove_column(:creators, :cgtrader_user, :string)
2025-08-25T14:53:04.995092415Z    -> 0.0044s
2025-08-25T14:53:04.995100191Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0885s) ==============
2025-08-25T14:53:04.995108097Z 
2025-08-25T14:53:04.995115712Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-08-25T14:53:04.995123588Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-08-25T14:53:04.995131484Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-08-25T14:53:04.995142566Z    -> 0.0554s
2025-08-25T14:53:04.995150392Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0554s) ==
2025-08-25T14:53:04.995158288Z 
2025-08-25T14:53:04.995166254Z Migrating to AddYUpToParts (20210318202638)
2025-08-25T14:53:04.995174250Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-08-25T14:53:04.995182437Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-08-25T14:53:04.995190302Z    -> 0.0146s
2025-08-25T14:53:04.995198269Z == 20210318202638 AddYUpToParts: migrated (0.0146s) ===========================
2025-08-25T14:53:04.995207026Z 
2025-08-25T14:53:04.995214922Z Migrating to CreateImages (20210321164508)
2025-08-25T14:53:04.995222848Z == 20210321164508 CreateImages: migrating =====================================
2025-08-25T14:53:04.995231235Z -- create_table(:images)
2025-08-25T14:53:04.995239111Z    -> 0.0149s
2025-08-25T14:53:04.995247297Z == 20210321164508 CreateImages: migrated (0.0150s) ============================
2025-08-25T14:53:04.995255704Z 
2025-08-25T14:53:04.995263410Z Migrating to CreateDelayedJobs (20210330215825)
2025-08-25T14:53:04.995271386Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-08-25T14:53:04.995279783Z -- create_table(:delayed_jobs)
2025-08-25T14:53:04.995287979Z    -> 0.0082s
2025-08-25T14:53:05.905437686Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-08-25T14:53:05.905472305Z    -> 0.0002s
2025-08-25T14:53:05.905482225Z == 20210330215825 CreateDelayedJobs: migrated (0.0084s) =======================
2025-08-25T14:53:05.905490572Z 
2025-08-25T14:53:05.905512767Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-08-25T14:53:05.905521184Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-08-25T14:53:05.905529230Z -- rename_table(:parts, :model_files)
2025-08-25T14:53:05.905537076Z    -> 0.0018s
2025-08-25T14:53:05.905544851Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-08-25T14:53:05.905552747Z    -> 0.0365s
2025-08-25T14:53:05.905560563Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0383s) =================
2025-08-25T14:53:05.905568569Z 
2025-08-25T14:53:05.905576175Z Migrating to RemoveImagesTable (20220106220519)
2025-08-25T14:53:05.905584401Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-08-25T14:53:05.905592327Z -- drop_table(:images)
2025-08-25T14:53:05.905600063Z    -> 0.0003s
2025-08-25T14:53:05.905607818Z == 20220106220519 RemoveImagesTable: migrated (0.0003s) =======================
2025-08-25T14:53:05.905615694Z 
2025-08-25T14:53:05.905623259Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-08-25T14:53:05.905631095Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-08-25T14:53:05.905639041Z -- table_exists?(:active_storage_blobs)
2025-08-25T14:53:05.905646927Z    -> 0.0009s
2025-08-25T14:53:05.905654653Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0009s) ======
2025-08-25T14:53:05.905662538Z 
2025-08-25T14:53:05.905670114Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-08-25T14:53:05.905677919Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-08-25T14:53:05.905685755Z -- table_exists?(:active_storage_blobs)
2025-08-25T14:53:05.905693501Z    -> 0.0001s
2025-08-25T14:53:05.905701226Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-08-25T14:53:05.905709854Z 
2025-08-25T14:53:05.905717940Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-08-25T14:53:05.905726106Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-08-25T14:53:05.905734012Z -- table_exists?(:active_storage_blobs)
2025-08-25T14:53:05.905741778Z    -> 0.0001s
2025-08-25T14:53:05.905749764Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-08-25T14:53:05.905757700Z 
2025-08-25T14:53:05.905765315Z Migrating to DeviseCreateUsers (20220614210023)
2025-08-25T14:53:05.905773392Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-08-25T14:53:05.905781258Z -- create_table(:users)
2025-08-25T14:53:05.905788963Z    -> 0.0012s
2025-08-25T14:53:05.905806248Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-08-25T14:53:05.905814805Z    -> 0.0016s
2025-08-25T14:53:05.905822561Z == 20220614210023 DeviseCreateUsers: migrated (0.0028s) =======================
2025-08-25T14:53:05.905830617Z 
2025-08-25T14:53:05.905838292Z Migrating to AddUsernameToUsers (20220614211256)
2025-08-25T14:53:05.905846399Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-08-25T14:53:05.905855958Z -- add_column(:users, :username, :string, {null: false})
2025-08-25T14:53:05.905864094Z    -> 0.0215s
2025-08-25T14:53:05.905872261Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-08-25T14:53:05.905880748Z    -> 0.0002s
2025-08-25T14:53:05.905888604Z == 20220614211256 AddUsernameToUsers: migrated (0.0217s) ======================
2025-08-25T14:53:05.905896620Z 
2025-08-25T14:53:05.905904386Z Migrating to AddAdminToUsers (20220614213902)
2025-08-25T14:53:05.905912462Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-08-25T14:53:05.905920498Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-08-25T14:53:05.905928324Z    -> 0.0005s
2025-08-25T14:53:05.905936450Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-08-25T14:53:05.905944607Z 
2025-08-25T14:53:05.905952603Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-08-25T14:53:05.905960919Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-08-25T14:53:05.905968825Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-08-25T14:53:05.905978585Z    -> 0.0012s
2025-08-25T14:53:05.905986381Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0013s) =============
2025-08-25T14:53:05.905994287Z 
2025-08-25T14:53:05.906002122Z Migrating to CreateSettings (20220619174307)
2025-08-25T14:53:05.906009898Z == 20220619174307 CreateSettings: migrating ===================================
2025-08-25T14:53:05.906018044Z -- create_table(:settings)
2025-08-25T14:53:05.906025780Z    -> 0.0028s
2025-08-25T14:53:05.906033536Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-08-25T14:53:05.906041953Z    -> 0.0002s
2025-08-25T14:53:05.906049648Z == 20220619174307 CreateSettings: migrated (0.0031s) ==========================
2025-08-25T14:53:05.906057634Z 
2025-08-25T14:53:05.906065710Z Migrating to AddScaleFactorToModels (20220626152444)
2025-08-25T14:53:05.906074107Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-08-25T14:53:05.906091512Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-08-25T14:53:05.906099539Z    -> 0.0098s
2025-08-25T14:53:05.906107254Z == 20220626152444 AddScaleFactorToModels: migrated (0.0120s) ==================
2025-08-25T14:53:05.906115721Z 
2025-08-25T14:53:05.906123557Z Migrating to AddDigestToModelFiles (20220702202932)
2025-08-25T14:53:05.906131363Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-08-25T14:53:05.906139249Z -- add_column(:model_files, :digest, :string)
2025-08-25T14:53:05.906147054Z    -> 0.0023s
2025-08-25T14:53:05.906154770Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-08-25T14:53:05.906162846Z    -> 0.0002s
2025-08-25T14:53:05.906170612Z == 20220702202932 AddDigestToModelFiles: migrated (0.0043s) ===================
2025-08-25T14:53:05.906178578Z 
2025-08-25T14:53:05.906186163Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-08-25T14:53:05.906194009Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-08-25T14:53:05.906202426Z -- 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-08-25T14:53:05.906213839Z    -> 0.0007s
2025-08-25T14:53:05.906221644Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0011s) ==============
2025-08-25T14:53:05.906229590Z 
2025-08-25T14:53:05.906237216Z Migrating to CreateProblems (20221210001132)
2025-08-25T14:53:05.906245092Z == 20221210001132 CreateProblems: migrating ===================================
2025-08-25T14:53:05.906252998Z -- create_table(:problems)
2025-08-25T14:53:05.906260723Z    -> 0.0008s
2025-08-25T14:53:05.906268459Z == 20221210001132 CreateProblems: migrated (0.0011s) ==========================
2025-08-25T14:53:05.906276385Z 
2025-08-25T14:53:05.906284070Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-08-25T14:53:05.906292046Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-08-25T14:53:05.906299952Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0156s) ========
2025-08-25T14:53:05.906308139Z 
2025-08-25T14:53:05.906315744Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-08-25T14:53:05.906323580Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-08-25T14:53:05.906331506Z -- create_table(:favorites, {force: true})
2025-08-25T14:53:05.906339261Z    -> 0.0038s
2025-08-25T14:53:05.906356927Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-08-25T14:53:05.906365474Z    -> 0.0001s
2025-08-25T14:53:05.906373510Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-08-25T14:53:05.906382178Z    -> 0.0001s
2025-08-25T14:53:05.906390414Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-08-25T14:53:05.906399723Z    -> 0.0001s
2025-08-25T14:53:05.906407389Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0046s) ================
2025-08-25T14:53:05.906415274Z 
2025-08-25T14:53:05.906423170Z Migrating to MovePrintedToFavorites (20221220223040)
2025-08-25T14:53:05.906430996Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-08-25T14:53:05.906439122Z == 20221220223040 MovePrintedToFavorites: migrated (0.3082s) ==================
2025-08-25T14:53:05.906447740Z 
2025-08-25T14:53:05.906455556Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-08-25T14:53:05.906463572Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-08-25T14:53:05.906471548Z -- remove_column(:model_files, :printed, :boolean)
2025-08-25T14:53:05.906479514Z    -> 0.0276s
2025-08-25T14:53:05.906487360Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0279s) ===============
2025-08-25T14:53:05.906495636Z 
2025-08-25T14:53:05.906503192Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-08-25T14:53:05.906512089Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-08-25T14:53:05.906520306Z -- add_column(:models, :notes, :text)
2025-08-25T14:53:05.906528963Z    -> 0.0014s
2025-08-25T14:53:05.906537000Z -- add_column(:models, :excerpt, :text)
2025-08-25T14:53:05.906545076Z    -> 0.0023s
2025-08-25T14:53:05.906553032Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0037s) =================
2025-08-25T14:53:05.906560948Z 
2025-08-25T14:53:05.906568834Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-08-25T14:53:05.906576750Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-08-25T14:53:05.906585177Z -- add_column(:creators, :notes, :text)
2025-08-25T14:53:05.906593543Z    -> 0.0005s
2025-08-25T14:53:05.906601379Z -- add_column(:creators, :excerpt, :text)
2025-08-25T14:53:05.906609706Z    -> 0.0004s
2025-08-25T14:53:05.906617462Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-08-25T14:53:05.906625438Z 
2025-08-25T14:53:05.906633033Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-08-25T14:53:05.906649927Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-08-25T14:53:05.906657913Z -- add_column(:model_files, :notes, :text)
2025-08-25T14:53:05.906665699Z    -> 0.0005s
2025-08-25T14:53:05.906673424Z -- add_column(:model_files, :excerpt, :text)
2025-08-25T14:53:05.906681250Z    -> 0.0005s
2025-08-25T14:53:05.906689336Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0010s) =============
2025-08-25T14:53:05.906697252Z 
2025-08-25T14:53:05.906705609Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-08-25T14:53:05.906714237Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-08-25T14:53:05.906722714Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0206s) =================
2025-08-25T14:53:05.906731221Z 
2025-08-25T14:53:05.906738926Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-08-25T14:53:05.906747313Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-08-25T14:53:05.906755189Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-08-25T14:53:05.906763606Z    -> 0.0442s
2025-08-25T14:53:05.906771372Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0443s) =============
2025-08-25T14:53:05.906779408Z 
2025-08-25T14:53:05.906787063Z Migrating to RenameExcerptToCaption (20230222155910)
2025-08-25T14:53:05.906794869Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-08-25T14:53:05.906802795Z -- rename_column(:creators, :excerpt, :caption)
2025-08-25T14:53:05.906810601Z    -> 0.0220s
2025-08-25T14:53:05.906818326Z -- rename_column(:models, :excerpt, :caption)
2025-08-25T14:53:05.906826132Z    -> 0.0236s
2025-08-25T14:53:05.906833877Z -- rename_column(:model_files, :excerpt, :caption)
2025-08-25T14:53:05.906842535Z    -> 0.0194s
2025-08-25T14:53:05.906850912Z == 20230222155910 RenameExcerptToCaption: migrated (0.0674s) ==================
2025-08-25T14:53:05.906859469Z 
2025-08-25T14:53:05.906867375Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-08-25T14:53:05.906875231Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-08-25T14:53:05.906883407Z -- add_column(:libraries, :notes, :string)
2025-08-25T14:53:05.906891183Z    -> 0.0022s
2025-08-25T14:53:05.906898979Z -- add_column(:libraries, :caption, :string)
2025-08-25T14:53:06.442632550Z    -> 0.0004s
2025-08-25T14:53:06.442670286Z -- add_column(:libraries, :name, :string)
2025-08-25T14:53:06.442680046Z    -> 0.0004s
2025-08-25T14:53:06.442704686Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0117s) ============
2025-08-25T14:53:06.442714606Z 
2025-08-25T14:53:06.442723263Z Migrating to AddTagregexToLibrary (20230305180823)
2025-08-25T14:53:06.442732532Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-08-25T14:53:06.442741039Z -- add_column(:libraries, :tag_regex, :text)
2025-08-25T14:53:06.442749586Z    -> 0.0020s
2025-08-25T14:53:06.442758043Z == 20230305180823 AddTagregexToLibrary: migrated (0.0037s) ====================
2025-08-25T14:53:06.442766590Z 
2025-08-25T14:53:06.442774737Z Migrating to AddIconToLibrary (20230307215826)
2025-08-25T14:53:06.442783043Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-08-25T14:53:06.442791540Z -- add_column(:libraries, :icon, :text)
2025-08-25T14:53:06.442799757Z    -> 0.0020s
2025-08-25T14:53:06.442808004Z == 20230307215826 AddIconToLibrary: migrated (0.0036s) ========================
2025-08-25T14:53:06.442816070Z 
2025-08-25T14:53:06.442824026Z Migrating to CreateCollection (20230308004237)
2025-08-25T14:53:06.442831962Z == 20230308004237 CreateCollection: migrating =================================
2025-08-25T14:53:06.442840369Z -- create_table(:collections)
2025-08-25T14:53:06.442848225Z    -> 0.0029s
2025-08-25T14:53:06.442856080Z == 20230308004237 CreateCollection: migrated (0.0070s) ========================
2025-08-25T14:53:06.442864147Z 
2025-08-25T14:53:06.442871982Z Migrating to AddCollectionToModels (20230308005021)
2025-08-25T14:53:06.442879929Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-08-25T14:53:06.442887925Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-08-25T14:53:06.442895941Z    -> 0.0194s
2025-08-25T14:53:06.442904117Z == 20230308005021 AddCollectionToModels: migrated (0.0232s) ===================
2025-08-25T14:53:06.442912143Z 
2025-08-25T14:53:06.442919899Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-08-25T14:53:06.442927815Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-08-25T14:53:06.442935891Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0022s) =============
2025-08-25T14:53:06.442943947Z 
2025-08-25T14:53:06.442951663Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-08-25T14:53:06.442959619Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-08-25T14:53:06.442967655Z -- rename_column(:collections, :excerpt, :caption)
2025-08-25T14:53:06.442975591Z    -> 0.0051s
2025-08-25T14:53:06.442983677Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0051s) ========
2025-08-25T14:53:06.443001574Z 
2025-08-25T14:53:06.443009479Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-08-25T14:53:06.443017455Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-08-25T14:53:06.443025492Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-08-25T14:53:06.443033538Z 
2025-08-25T14:53:06.443041283Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-08-25T14:53:06.443050692Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-08-25T14:53:06.443058979Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-08-25T14:53:06.443068609Z    -> 0.0019s
2025-08-25T14:53:06.443076675Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0019s) ===============
2025-08-25T14:53:06.443084851Z 
2025-08-25T14:53:06.443092657Z Migrating to AddCollectionToCollections (20230324000000)
2025-08-25T14:53:06.443100683Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-08-25T14:53:06.443108759Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-08-25T14:53:06.443116866Z    -> 0.0071s
2025-08-25T14:53:06.443124792Z == 20230324000000 AddCollectionToCollections: migrated (0.0092s) ==============
2025-08-25T14:53:06.443132888Z 
2025-08-25T14:53:06.443140684Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-08-25T14:53:06.443148680Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-08-25T14:53:06.443156716Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0506s) =========
2025-08-25T14:53:06.443164762Z 
2025-08-25T14:53:06.443172879Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-08-25T14:53:06.443180905Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-08-25T14:53:06.443188951Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0064s) 
2025-08-25T14:53:06.443197057Z 
2025-08-25T14:53:06.443205003Z Migrating to AddSlugs (20230615135601)
2025-08-25T14:53:06.443212899Z == 20230615135601 AddSlugs: migrating =========================================
2025-08-25T14:53:06.443220955Z -- add_column(:models, :slug, :string)
2025-08-25T14:53:06.443229012Z    -> 0.0027s
2025-08-25T14:53:06.443237208Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-08-25T14:53:06.443245755Z    -> 0.0019s
2025-08-25T14:53:06.443253721Z -- add_column(:collections, :slug, :string)
2025-08-25T14:53:06.443261677Z    -> 0.0005s
2025-08-25T14:53:06.443278752Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-08-25T14:53:06.443287099Z    -> 0.0001s
2025-08-25T14:53:06.443295005Z -- add_column(:creators, :slug, :string)
2025-08-25T14:53:06.443302920Z    -> 0.0005s
2025-08-25T14:53:06.443310846Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-08-25T14:53:06.443318973Z    -> 0.0001s
2025-08-25T14:53:06.443327109Z == 20230615135601 AddSlugs: migrated (0.0063s) ================================
2025-08-25T14:53:06.443335195Z 
2025-08-25T14:53:06.443342981Z Migrating to GenerateSlugs (20230617222353)
2025-08-25T14:53:06.443351368Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-08-25T14:53:06.443359745Z == 20230617222353 GenerateSlugs: migrated (0.0515s) ===========================
2025-08-25T14:53:06.443368302Z 
2025-08-25T14:53:06.443376288Z Migrating to MakeNamesUnique (20230628194944)
2025-08-25T14:53:06.443384214Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-08-25T14:53:06.443393363Z == 20230628194944 MakeNamesUnique: migrated (0.0030s) =========================
2025-08-25T14:53:06.443402010Z 
2025-08-25T14:53:06.443409976Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-08-25T14:53:06.443418022Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-08-25T14:53:06.443426419Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-08-25T14:53:06.443435157Z    -> 0.0020s
2025-08-25T14:53:06.443443474Z -- remove_index(:creators, :slug)
2025-08-25T14:53:06.443451680Z    -> 0.0004s
2025-08-25T14:53:06.443459957Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-08-25T14:53:06.443468193Z    -> 0.0001s
2025-08-25T14:53:06.443476560Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-08-25T14:53:06.443485398Z    -> 0.0001s
2025-08-25T14:53:06.443493474Z -- remove_index(:collections, :slug)
2025-08-25T14:53:06.443501581Z    -> 0.0230s
2025-08-25T14:53:06.443509927Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-08-25T14:53:06.443518344Z    -> 0.0006s
2025-08-25T14:53:06.443526250Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0267s) ======
2025-08-25T14:53:06.443535208Z 
2025-08-25T14:53:06.443543525Z Migrating to AddSizeToModelFiles (20230707082403)
2025-08-25T14:53:06.443551551Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-08-25T14:53:06.443559818Z -- add_column(:model_files, :size, :integer)
2025-08-25T14:53:06.443578375Z    -> 0.0006s
2025-08-25T14:53:06.443586401Z == 20230707082403 AddSizeToModelFiles: migrated (0.0009s) =====================
2025-08-25T14:53:06.443594628Z 
2025-08-25T14:53:06.443602614Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-08-25T14:53:06.443610580Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-08-25T14:53:06.443618747Z -- change_column(:model_files, :size, :bigint)
2025-08-25T14:53:06.443626903Z    -> 0.0088s
2025-08-25T14:53:06.443634759Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0091s) ==================
2025-08-25T14:53:06.443642815Z 
2025-08-25T14:53:06.443650571Z Migrating to AddNoteToProblems (20230711111009)
2025-08-25T14:53:06.443658497Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-08-25T14:53:06.443666533Z -- add_column(:problems, :note, :string, {default: nil})
2025-08-25T14:53:06.443674509Z    -> 0.0011s
2025-08-25T14:53:06.443682445Z == 20230711111009 AddNoteToProblems: migrated (0.0021s) =======================
2025-08-25T14:53:06.443690501Z 
2025-08-25T14:53:06.443698257Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-08-25T14:53:06.443706193Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-08-25T14:53:06.443715321Z -- 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-08-25T14:53:06.443729249Z    -> 0.0006s
2025-08-25T14:53:06.443737225Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0006s) ================
2025-08-25T14:53:06.443745332Z 
2025-08-25T14:53:06.443753177Z Migrating to AddLicenseToModel (20240127143358)
2025-08-25T14:53:06.443761183Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-08-25T14:53:06.443769270Z -- add_column(:models, :license, :string)
2025-08-25T14:53:06.443777256Z    -> 0.0005s
2025-08-25T14:53:06.443785162Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-08-25T14:53:06.443793228Z 
2025-08-25T14:53:06.443801004Z Migrating to AddIgnoredToProblems (20240131134832)
2025-08-25T14:53:06.443809000Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-08-25T14:53:06.443818960Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-08-25T14:53:06.443827096Z    -> 0.0006s
2025-08-25T14:53:06.443856395Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-08-25T14:53:06.443867678Z 
2025-08-25T14:53:06.443875484Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-08-25T14:53:06.443883480Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-08-25T14:53:06.443891546Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-08-25T14:53:06.443899702Z    -> 0.0129s
2025-08-25T14:53:06.443907648Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0129s) ======
2025-08-25T14:53:06.443915715Z 
2025-08-25T14:53:06.443923400Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-08-25T14:53:06.443931386Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-08-25T14:53:06.443939432Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-08-25T14:53:06.443947910Z    -> 0.0009s
2025-08-25T14:53:06.443955856Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0010s) ===============
2025-08-25T14:53:06.443963902Z 
2025-08-25T14:53:06.443971938Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-08-25T14:53:06.443979994Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-08-25T14:53:06.443988000Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-08-25T14:53:06.443996257Z    -> 0.0002s
2025-08-25T14:53:06.444004343Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-08-25T14:53:06.444012780Z    -> 0.0009s
2025-08-25T14:53:06.444020716Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-08-25T14:53:06.444029103Z    -> 0.0001s
2025-08-25T14:53:06.444037440Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-08-25T14:53:06.444045997Z    -> 0.0042s
2025-08-25T14:53:06.908514880Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0056s) =================
2025-08-25T14:53:06.908560882Z 
2025-08-25T14:53:06.908570341Z Migrating to CreateFlipperTables (20240306095646)
2025-08-25T14:53:06.908579049Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-08-25T14:53:06.908587606Z -- create_table(:flipper_features)
2025-08-25T14:53:06.908595973Z    -> 0.0027s
2025-08-25T14:53:06.908604470Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-08-25T14:53:06.908613087Z    -> 0.0045s
2025-08-25T14:53:06.908621354Z -- create_table(:flipper_gates)
2025-08-25T14:53:06.908658529Z    -> 0.0003s
2025-08-25T14:53:06.908667417Z -- 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-08-25T14:53:06.908676495Z    -> 0.0001s
2025-08-25T14:53:06.908684611Z == 20240306095646 CreateFlipperTables: migrated (0.0077s) =====================
2025-08-25T14:53:06.908693028Z 
2025-08-25T14:53:06.908700844Z Migrating to RolifyCreateRoles (20240319155251)
2025-08-25T14:53:06.908708840Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-08-25T14:53:06.908717217Z -- create_table(:roles)
2025-08-25T14:53:06.908725093Z    -> 0.0373s
2025-08-25T14:53:06.908733229Z -- create_table(:users_roles, {id: false})
2025-08-25T14:53:06.908741095Z    -> 0.0005s
2025-08-25T14:53:06.908748971Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-08-25T14:53:06.908757238Z    -> 0.0047s
2025-08-25T14:53:06.908765164Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-08-25T14:53:06.908773561Z    -> 0.0002s
2025-08-25T14:53:06.908781436Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-08-25T14:53:06.908789773Z    -> 0.0001s
2025-08-25T14:53:06.908797890Z == 20240319155251 RolifyCreateRoles: migrated (0.0585s) =======================
2025-08-25T14:53:06.908806226Z 
2025-08-25T14:53:06.908814423Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-08-25T14:53:06.908822549Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-08-25T14:53:06.908830565Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0093s) ==================
2025-08-25T14:53:06.908838982Z 
2025-08-25T14:53:06.908847019Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-08-25T14:53:06.908854965Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-08-25T14:53:06.908862941Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-08-25T14:53:06.908871067Z    -> 0.0235s
2025-08-25T14:53:06.908879063Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0249s) ====================
2025-08-25T14:53:06.908887149Z 
2025-08-25T14:53:06.908894835Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-08-25T14:53:06.908902781Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-08-25T14:53:06.908910767Z -- add_column(:users, :reset_password_token, :string)
2025-08-25T14:53:06.908918663Z    -> 0.0011s
2025-08-25T14:53:06.908926529Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-08-25T14:53:06.908945607Z    -> 0.0002s
2025-08-25T14:53:06.908953774Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0032s) ============
2025-08-25T14:53:06.908961850Z 
2025-08-25T14:53:06.908969555Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-08-25T14:53:06.908977481Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-08-25T14:53:06.908985477Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0255s) ==============
2025-08-25T14:53:06.908993494Z 
2025-08-25T14:53:06.909001209Z Migrating to AddRememberableToUsers (20240410221112)
2025-08-25T14:53:06.909009115Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-08-25T14:53:06.909017111Z -- add_column(:users, :remember_created_at, :datetime)
2025-08-25T14:53:06.909025418Z    -> 0.0032s
2025-08-25T14:53:06.909033314Z == 20240410221112 AddRememberableToUsers: migrated (0.0045s) ==================
2025-08-25T14:53:06.909041360Z 
2025-08-25T14:53:06.909049086Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-08-25T14:53:06.909057062Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-08-25T14:53:06.909065098Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-08-25T14:53:06.909073064Z    -> 0.0007s
2025-08-25T14:53:06.909080930Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0019s) ===========
2025-08-25T14:53:06.909089056Z 
2025-08-25T14:53:06.909096752Z Migrating to DropDelayedJobs (20240418112821)
2025-08-25T14:53:06.909104758Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-08-25T14:53:06.909112924Z -- drop_table(:delayed_jobs)
2025-08-25T14:53:06.909120840Z    -> 0.0018s
2025-08-25T14:53:06.909128746Z == 20240418112821 DropDelayedJobs: migrated (0.0116s) =========================
2025-08-25T14:53:06.909136762Z 
2025-08-25T14:53:06.909144498Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-08-25T14:53:06.909152504Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-08-25T14:53:06.909160480Z -- add_column(:users, :interface_language, :string)
2025-08-25T14:53:06.909168386Z    -> 0.0007s
2025-08-25T14:53:06.909176402Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0040s) =============
2025-08-25T14:53:06.909184408Z 
2025-08-25T14:53:06.909192284Z Migrating to AddLockableToUsers (20240610120318)
2025-08-25T14:53:06.909200390Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-08-25T14:53:06.909208787Z -- change_table(:users)
2025-08-25T14:53:06.909226904Z    -> 0.0016s
2025-08-25T14:53:06.909235080Z == 20240610120318 AddLockableToUsers: migrated (0.0020s) ======================
2025-08-25T14:53:06.909243337Z 
2025-08-25T14:53:06.909251513Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-08-25T14:53:06.909260121Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-08-25T14:53:06.909268127Z -- add_column(:model_files, :attachment_data, :json)
2025-08-25T14:53:06.909276373Z    -> 0.0007s
2025-08-25T14:53:06.909284700Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0010s) ===========
2025-08-25T14:53:06.909293217Z 
2025-08-25T14:53:06.909300923Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-08-25T14:53:06.909309520Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-08-25T14:53:06.909317596Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0132s) ==================
2025-08-25T14:53:06.909325663Z 
2025-08-25T14:53:06.909333358Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-08-25T14:53:06.909341334Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-08-25T14:53:06.909349340Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-08-25T14:53:06.909358078Z    -> 0.0007s
2025-08-25T14:53:06.909366194Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0026s) ============
2025-08-25T14:53:06.909374291Z 
2025-08-25T14:53:06.909382577Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-08-25T14:53:06.909390784Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-08-25T14:53:06.909399020Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-08-25T14:53:06.909407457Z    -> 0.0006s
2025-08-25T14:53:06.909415383Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-08-25T14:53:06.909423660Z    -> 0.0006s
2025-08-25T14:53:06.909431826Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-08-25T14:53:06.909440604Z    -> 0.0006s
2025-08-25T14:53:06.909448730Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-08-25T14:53:06.909456827Z    -> 0.0048s
2025-08-25T14:53:06.909464743Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-08-25T14:53:06.909472779Z    -> 0.0006s
2025-08-25T14:53:06.909480645Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0083s) ====================
2025-08-25T14:53:06.909489032Z 
2025-08-25T14:53:06.909496747Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-08-25T14:53:06.909504683Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-08-25T14:53:06.909521888Z -- remove_index(:libraries, :path)
2025-08-25T14:53:06.909529864Z    -> 0.0010s
2025-08-25T14:53:06.909538010Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0017s) ================
2025-08-25T14:53:06.909546016Z 
2025-08-25T14:53:06.909553722Z Migrating to CreateFederailsActors (20240727113215)
2025-08-25T14:53:06.909561698Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-08-25T14:53:06.909570005Z -- create_table(:federails_actors)
2025-08-25T14:53:06.909577851Z    -> 0.0008s
2025-08-25T14:53:06.909585696Z -- foreign_key_exists?(:federails_actors, :users)
2025-08-25T14:53:06.909593582Z    -> 0.0016s
2025-08-25T14:53:06.909601699Z -- remove_foreign_key(:federails_actors, :users)
2025-08-25T14:53:06.909609594Z    -> 0.0117s
2025-08-25T14:53:06.909617410Z -- remove_index(:federails_actors, :user_id)
2025-08-25T14:53:06.909625386Z    -> 0.0004s
2025-08-25T14:53:06.909633252Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-08-25T14:53:06.909641469Z    -> 0.0001s
2025-08-25T14:53:06.909649274Z -- add_foreign_key(:federails_actors, :users)
2025-08-25T14:53:06.909657160Z    -> 0.0096s
2025-08-25T14:53:06.909665016Z == 20240727113215 CreateFederailsActors: migrated (0.0252s) ===================
2025-08-25T14:53:06.909673052Z 
2025-08-25T14:53:06.909680818Z Migrating to CreateFederailsFollowings (20240727113216)
2025-08-25T14:53:06.909689535Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-08-25T14:53:06.909697622Z -- create_table(:federails_followings)
2025-08-25T14:53:06.909705498Z    -> 0.0014s
2025-08-25T14:53:06.909713384Z == 20240727113216 CreateFederailsFollowings: migrated (0.0014s) ===============
2025-08-25T14:53:06.909721470Z 
2025-08-25T14:53:06.909729536Z Migrating to CreateFederailsActivities (20240727113217)
2025-08-25T14:53:06.909737572Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-08-25T14:53:06.909745628Z -- create_table(:federails_activities)
2025-08-25T14:53:06.909753584Z    -> 0.0086s
2025-08-25T14:53:06.909761731Z == 20240727113217 CreateFederailsActivities: migrated (0.0086s) ===============
2025-08-25T14:53:06.909769967Z 
2025-08-25T14:53:06.909777763Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-08-25T14:53:06.909785789Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-08-25T14:53:06.909793856Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-08-25T14:53:06.909802072Z    -> 0.0080s
2025-08-25T14:53:06.909818966Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-08-25T14:53:06.909827433Z    -> 0.0004s
2025-08-25T14:53:06.909835419Z -- change_table(:federails_actors)
2025-08-25T14:53:06.909843606Z    -> 0.0278s
2025-08-25T14:53:06.909851692Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0363s) =======
2025-08-25T14:53:06.909859999Z 
2025-08-25T14:53:06.909867744Z Migrating to CreateFederailsActors (20240731165647)
2025-08-25T14:53:06.909875650Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-08-25T14:53:06.909883757Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-08-25T14:53:06.909892073Z 
2025-08-25T14:53:06.909899789Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-08-25T14:53:06.909907735Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-08-25T14:53:06.909915731Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-08-25T14:53:06.909924018Z 
2025-08-25T14:53:06.909931793Z Migrating to BackfillActivities (20240805111500)
2025-08-25T14:53:06.909939729Z == 20240805111500 BackfillActivities: migrating ===============================
2025-08-25T14:53:06.909947986Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-08-25T14:53:06.909956082Z 
2025-08-25T14:53:06.909963918Z Migrating to CreateCaberRelations (20240827155630)
2025-08-25T14:53:06.909972014Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-08-25T14:53:06.909980261Z -- create_table(:caber_relations)
2025-08-25T14:53:06.909988367Z    -> 0.0385s
2025-08-25T14:53:06.909996504Z == 20240827155630 CreateCaberRelations: migrated (0.0385s) ====================
2025-08-25T14:53:06.910005382Z 
2025-08-25T14:53:06.910013278Z Migrating to AddDefaultAccessControls (20240830121749)
2025-08-25T14:53:06.910021945Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-08-25T14:53:06.910030552Z == 20240830121749 AddDefaultAccessControls: migrated (0.0229s) ================
2025-08-25T14:53:06.910038669Z 
2025-08-25T14:53:06.910047206Z Migrating to RenameDefaultRoles (20240830151650)
2025-08-25T14:53:07.548483713Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-08-25T14:53:07.548531610Z == 20240830151650 RenameDefaultRoles: migrated (0.0391s) ======================
2025-08-25T14:53:07.548543824Z 
2025-08-25T14:53:07.548553143Z Migrating to AddPublicIDsToModels (20240904151944)
2025-08-25T14:53:07.548561630Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-08-25T14:53:07.548586350Z -- add_column(:models, :public_id, :string)
2025-08-25T14:53:07.548596771Z    -> 0.0011s
2025-08-25T14:53:07.548607212Z -- add_index(:models, :public_id)
2025-08-25T14:53:07.548617543Z    -> 0.0025s
2025-08-25T14:53:07.548626902Z -- add_column(:model_files, :public_id, :string)
2025-08-25T14:53:07.548634998Z    -> 0.0006s
2025-08-25T14:53:07.548643415Z -- add_index(:model_files, :public_id)
2025-08-25T14:53:07.548651341Z    -> 0.0001s
2025-08-25T14:53:07.548659257Z -- add_column(:problems, :public_id, :string)
2025-08-25T14:53:07.548667253Z    -> 0.0006s
2025-08-25T14:53:07.548675119Z -- add_index(:problems, :public_id)
2025-08-25T14:53:07.548683055Z    -> 0.0001s
2025-08-25T14:53:07.548691903Z -- add_column(:creators, :public_id, :string)
2025-08-25T14:53:07.548701803Z    -> 0.0006s
2025-08-25T14:53:07.548712073Z -- add_index(:creators, :public_id)
2025-08-25T14:53:07.548720120Z    -> 0.0002s
2025-08-25T14:53:07.548728056Z -- add_column(:collections, :public_id, :string)
2025-08-25T14:53:07.548736002Z    -> 0.0006s
2025-08-25T14:53:07.548743867Z -- add_index(:collections, :public_id)
2025-08-25T14:53:07.548752244Z    -> 0.0001s
2025-08-25T14:53:07.548761212Z -- add_column(:libraries, :public_id, :string)
2025-08-25T14:53:07.548771112Z    -> 0.0006s
2025-08-25T14:53:07.548781383Z -- add_index(:libraries, :public_id)
2025-08-25T14:53:07.548789549Z    -> 0.0001s
2025-08-25T14:53:07.548797576Z == 20240904151944 AddPublicIDsToModels: migrated (0.0076s) ====================
2025-08-25T14:53:07.548805732Z 
2025-08-25T14:53:07.548813668Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-08-25T14:53:07.548821824Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-08-25T14:53:07.548830051Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:07.548838097Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0357s) ==============
2025-08-25T14:53:07.548846775Z 
2025-08-25T14:53:07.548854871Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-08-25T14:53:07.548863388Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-08-25T14:53:07.548873649Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-08-25T14:53:07.548883719Z 
2025-08-25T14:53:07.548893569Z Migrating to DeduplicateRoles (20240923114515)
2025-08-25T14:53:07.548902286Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-08-25T14:53:07.548911154Z == 20240923114515 DeduplicateRoles: migrated (0.1360s) ========================
2025-08-25T14:53:07.548930914Z 
2025-08-25T14:53:07.548940824Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-08-25T14:53:07.548950654Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-08-25T14:53:07.548960995Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-08-25T14:53:07.548971576Z    -> 0.1552s
2025-08-25T14:53:07.548983199Z -- add_index(:models, :name_lower)
2025-08-25T14:53:07.548992468Z    -> 0.0002s
2025-08-25T14:53:07.549000695Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-08-25T14:53:07.549009372Z    -> 0.0079s
2025-08-25T14:53:07.549017739Z -- add_index(:creators, :name_lower)
2025-08-25T14:53:07.549026136Z    -> 0.0001s
2025-08-25T14:53:07.549034192Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-08-25T14:53:07.549042649Z    -> 0.0094s
2025-08-25T14:53:07.549050816Z -- add_index(:collections, :name_lower)
2025-08-25T14:53:07.549058732Z    -> 0.0001s
2025-08-25T14:53:07.549066647Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1732s) =============
2025-08-25T14:53:07.549074844Z 
2025-08-25T14:53:07.549082610Z Migrating to AddKeypairToActors (20240926162407)
2025-08-25T14:53:07.549090666Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-08-25T14:53:07.549098722Z -- change_table(:federails_actors)
2025-08-25T14:53:07.549106638Z    -> 0.0021s
2025-08-25T14:53:07.549114554Z == 20240926162407 AddKeypairToActors: migrated (0.0021s) ======================
2025-08-25T14:53:07.549122831Z 
2025-08-25T14:53:07.549130877Z Migrating to AddUuids (20241004194445)
2025-08-25T14:53:07.549140095Z == 20241004194445 AddUuids: migrating =========================================
2025-08-25T14:53:07.549150266Z -- change_table(:federails_actors)
2025-08-25T14:53:07.549160787Z    -> 0.0029s
2025-08-25T14:53:07.549169946Z -- change_table(:federails_activities)
2025-08-25T14:53:07.549178132Z    -> 0.0008s
2025-08-25T14:53:07.549186018Z -- change_table(:federails_followings)
2025-08-25T14:53:07.549193934Z    -> 0.0008s
2025-08-25T14:53:07.549201850Z == 20241004194445 AddUuids: migrated (0.0046s) ================================
2025-08-25T14:53:07.549210617Z 
2025-08-25T14:53:07.549220227Z Migrating to CreateComments (20241007182824)
2025-08-25T14:53:07.549230137Z == 20241007182824 CreateComments: migrating ===================================
2025-08-25T14:53:07.549238934Z -- create_table(:comments)
2025-08-25T14:53:07.549257823Z    -> 0.0020s
2025-08-25T14:53:07.549265839Z == 20241007182824 CreateComments: migrated (0.0020s) ==========================
2025-08-25T14:53:07.549273865Z 
2025-08-25T14:53:07.549282693Z Migrating to AddSystemToComments (20241009122540)
2025-08-25T14:53:07.549292693Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-08-25T14:53:07.549302873Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-08-25T14:53:07.549311541Z    -> 0.0008s
2025-08-25T14:53:07.549319497Z == 20241009122540 AddSystemToComments: migrated (0.0008s) =====================
2025-08-25T14:53:07.549327663Z 
2025-08-25T14:53:07.549335749Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-08-25T14:53:07.549343705Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-08-25T14:53:07.549351742Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0015s) ============
2025-08-25T14:53:07.549359948Z 
2025-08-25T14:53:07.549367714Z Migrating to AddOmniauthToUsers (20241015090803)
2025-08-25T14:53:07.549375640Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-08-25T14:53:07.549383706Z -- add_column(:users, :auth_provider, :string)
2025-08-25T14:53:07.549391632Z    -> 0.0008s
2025-08-25T14:53:07.549399548Z -- add_column(:users, :auth_uid, :string)
2025-08-25T14:53:07.549408035Z    -> 0.0007s
2025-08-25T14:53:07.549416001Z == 20241015090803 AddOmniauthToUsers: migrated (0.0015s) ======================
2025-08-25T14:53:07.549424268Z 
2025-08-25T14:53:07.549432184Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-08-25T14:53:07.549440711Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-08-25T14:53:07.549450691Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-08-25T14:53:07.549460751Z    -> 0.0007s
2025-08-25T14:53:07.549469860Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-08-25T14:53:07.549478317Z    -> 0.0007s
2025-08-25T14:53:07.549486233Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0015s) =====
2025-08-25T14:53:07.549494389Z 
2025-08-25T14:53:07.549502125Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-08-25T14:53:07.549510582Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-08-25T14:53:07.549520461Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-08-25T14:53:07.549530602Z    -> 0.0008s
2025-08-25T14:53:07.549539350Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-08-25T14:53:07.549557717Z 
2025-08-25T14:53:07.549565863Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-08-25T14:53:07.549573879Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-08-25T14:53:07.549581935Z -- change_table(:users)
2025-08-25T14:53:07.549589801Z    -> 0.0009s
2025-08-25T14:53:07.549597677Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0009s) =====================
2025-08-25T14:53:07.549605703Z 
2025-08-25T14:53:07.549613429Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-08-25T14:53:07.549621395Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-08-25T14:53:07.549629862Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0058s) =================
2025-08-25T14:53:07.549638509Z 
2025-08-25T14:53:07.549646245Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-08-25T14:53:07.549655223Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-08-25T14:53:07.549665814Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-08-25T14:53:07.549676305Z    -> 0.0009s
2025-08-25T14:53:07.549686205Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-08-25T14:53:07.549696757Z    -> 0.0012s
2025-08-25T14:53:07.549706727Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-08-25T14:53:07.549715805Z    -> 0.0004s
2025-08-25T14:53:07.549724192Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-08-25T14:53:07.549732980Z    -> 0.0009s
2025-08-25T14:53:07.549741056Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-08-25T14:53:07.549749433Z    -> 0.0008s
2025-08-25T14:53:07.549757299Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-08-25T14:53:07.549765495Z    -> 0.0009s
2025-08-25T14:53:07.549774724Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-08-25T14:53:07.549783481Z    -> 0.0004s
2025-08-25T14:53:07.549792259Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0057s) ===================
2025-08-25T14:53:07.549802630Z 
2025-08-25T14:53:07.549812029Z Migrating to AddInProgressToProblems (20241105121830)
2025-08-25T14:53:07.549820877Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-08-25T14:53:07.549828943Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-08-25T14:53:07.549837009Z    -> 0.0008s
2025-08-25T14:53:07.549844925Z == 20241105121830 AddInProgressToProblems: migrated (0.0008s) =================
2025-08-25T14:53:07.549873082Z 
2025-08-25T14:53:07.549882891Z Migrating to ClearStuckProblems (20241118155027)
2025-08-25T14:53:07.549891028Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-08-25T14:53:07.549899184Z == 20241118155027 ClearStuckProblems: migrated (0.0256s) ======================
2025-08-25T14:53:07.549907251Z 
2025-08-25T14:53:07.549915257Z Migrating to AddApprovedToUser (20241122121621)
2025-08-25T14:53:07.549923273Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-08-25T14:53:07.549933483Z -- change_table(:users)
2025-08-25T14:53:07.549943253Z    -> 0.0014s
2025-08-25T14:53:07.549953093Z == 20241122121621 AddApprovedToUser: migrated (0.0014s) =======================
2025-08-25T14:53:07.549963283Z 
2025-08-25T14:53:07.549972692Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-08-25T14:53:07.549981961Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-08-25T14:53:07.549990498Z -- create_table(:federails_moderation_reports)
2025-08-25T14:53:07.549998685Z    -> 0.0029s
2025-08-25T14:53:07.550007052Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0029s) ========
2025-08-25T14:53:07.550015649Z 
2025-08-25T14:53:07.550023354Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-08-25T14:53:07.550031381Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-08-25T14:53:07.550039417Z -- create_table(:federails_moderation_domain_blocks)
2025-08-25T14:53:07.550047373Z    -> 0.0005s
2025-08-25T14:53:07.550055219Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-08-25T14:53:07.550063255Z 
2025-08-25T14:53:07.550071020Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-08-25T14:53:07.550079107Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-08-25T14:53:07.550087143Z -- change_column_null(:comments, :commenter_id, true)
2025-08-25T14:53:07.550095660Z    -> 0.0084s
2025-08-25T14:53:07.550105610Z -- change_column_null(:comments, :commenter_type, true)
2025-08-25T14:53:07.550115821Z    -> 0.0169s
2025-08-25T14:53:07.550124638Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-08-25T14:53:07.550133035Z    -> 0.0010s
2025-08-25T14:53:07.550141041Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-08-25T14:53:07.550149268Z    -> 0.0279s
2025-08-25T14:53:08.413415568Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0557s) =======
2025-08-25T14:53:08.413487373Z 
2025-08-25T14:53:08.413496531Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-08-25T14:53:08.413504828Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-08-25T14:53:08.413512964Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-08-25T14:53:08.413520970Z    -> 0.0009s
2025-08-25T14:53:08.413529237Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0010s) =================
2025-08-25T14:53:08.413537374Z 
2025-08-25T14:53:08.413545089Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-08-25T14:53:08.413553005Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-08-25T14:53:08.413561242Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1648s) ==================
2025-08-25T14:53:08.413569278Z 
2025-08-25T14:53:08.413576983Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-08-25T14:53:08.413584909Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-08-25T14:53:08.413593026Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-08-25T14:53:08.413601032Z    -> 0.0018s
2025-08-25T14:53:08.413608888Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0018s) ==========
2025-08-25T14:53:08.413616834Z 
2025-08-25T14:53:08.413624509Z Migrating to AddCreatorToCollections (20250222000000)
2025-08-25T14:53:08.413632375Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-08-25T14:53:08.413640371Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-08-25T14:53:08.413648367Z    -> 0.0275s
2025-08-25T14:53:08.413656403Z == 20250222000000 AddCreatorToCollections: migrated (0.0275s) =================
2025-08-25T14:53:08.413664359Z 
2025-08-25T14:53:08.413672075Z Migrating to AddLocalToActors (20250305171530)
2025-08-25T14:53:08.413679951Z == 20250305171530 AddLocalToActors: migrating =================================
2025-08-25T14:53:08.413687877Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-08-25T14:53:08.413695863Z    -> 0.0010s
2025-08-25T14:53:08.413703869Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-08-25T14:53:08.413712436Z    -> 0.0018s
2025-08-25T14:53:08.413720552Z    -> 0 rows
2025-08-25T14:53:08.413728378Z == 20250305171530 AddLocalToActors: migrated (0.0058s) ========================
2025-08-25T14:53:08.413736875Z 
2025-08-25T14:53:08.413744972Z Migrating to AddActorTypeToActors (20250407160721)
2025-08-25T14:53:08.413752888Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-08-25T14:53:08.413770273Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-08-25T14:53:08.413778549Z    -> 0.0009s
2025-08-25T14:53:08.413786615Z == 20250407160721 AddActorTypeToActors: migrated (0.0010s) ====================
2025-08-25T14:53:08.413794762Z 
2025-08-25T14:53:08.413802437Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-08-25T14:53:08.413810333Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-08-25T14:53:08.413819622Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-08-25T14:53:08.413827738Z    -> 0.0014s
2025-08-25T14:53:08.413835654Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0015s) =================
2025-08-25T14:53:08.413843600Z 
2025-08-25T14:53:08.413851336Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-08-25T14:53:08.413859352Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-08-25T14:53:08.413867488Z -- create_table(:oauth_applications)
2025-08-25T14:53:08.413875314Z    -> 0.0005s
2025-08-25T14:53:08.413883481Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-08-25T14:53:08.413891577Z    -> 0.0002s
2025-08-25T14:53:08.413899383Z -- create_table(:oauth_access_grants)
2025-08-25T14:53:08.413907699Z    -> 0.0006s
2025-08-25T14:53:08.413915826Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-08-25T14:53:08.413923832Z    -> 0.0001s
2025-08-25T14:53:08.413931668Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-08-25T14:53:08.413940165Z    -> 0.0085s
2025-08-25T14:53:08.413947940Z -- create_table(:oauth_access_tokens)
2025-08-25T14:53:08.413955946Z    -> 0.0006s
2025-08-25T14:53:08.413964253Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-08-25T14:53:08.413972099Z    -> 0.0001s
2025-08-25T14:53:08.413980055Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-08-25T14:53:08.413988011Z    -> 0.0001s
2025-08-25T14:53:08.413995967Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-08-25T14:53:08.414004334Z    -> 0.0091s
2025-08-25T14:53:08.414012240Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-08-25T14:53:08.414020246Z    -> 0.0084s
2025-08-25T14:53:08.414028132Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-08-25T14:53:08.414036429Z    -> 0.0091s
2025-08-25T14:53:08.414044755Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0376s) ==================
2025-08-25T14:53:08.414053172Z 
2025-08-25T14:53:08.414070187Z Migrating to AddOwnerToApplication (20250408145956)
2025-08-25T14:53:08.414078824Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-08-25T14:53:08.414086770Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-08-25T14:53:08.414094736Z    -> 0.0009s
2025-08-25T14:53:08.414102502Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-08-25T14:53:08.414110448Z    -> 0.0008s
2025-08-25T14:53:08.414118223Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-08-25T14:53:08.414126470Z    -> 0.0002s
2025-08-25T14:53:08.414134256Z == 20250408145956 AddOwnerToApplication: migrated (0.0068s) ===================
2025-08-25T14:53:08.414142212Z 
2025-08-25T14:53:08.414149847Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-08-25T14:53:08.414158424Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-08-25T14:53:08.414166340Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-08-25T14:53:08.414174396Z    -> 0.0121s
2025-08-25T14:53:08.414182383Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0134s) ============
2025-08-25T14:53:08.414190910Z 
2025-08-25T14:53:08.414198585Z Migrating to AddQuotaToUsers (20250409125753)
2025-08-25T14:53:08.414206852Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-08-25T14:53:08.414214828Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-08-25T14:53:08.414222794Z    -> 0.0010s
2025-08-25T14:53:08.414230590Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-08-25T14:53:08.414239017Z    -> 0.0009s
2025-08-25T14:53:08.414246812Z == 20250409125753 AddQuotaToUsers: migrated (0.0034s) =========================
2025-08-25T14:53:08.414254858Z 
2025-08-25T14:53:08.414262534Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-08-25T14:53:08.414270550Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-08-25T14:53:08.414278586Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-08-25T14:53:08.414286923Z    -> 0.0132s
2025-08-25T14:53:08.414294749Z -- add_index(:model_files, :filename_lower)
2025-08-25T14:53:08.414302615Z    -> 0.0002s
2025-08-25T14:53:08.414310380Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0147s) 
2025-08-25T14:53:08.414318557Z 
2025-08-25T14:53:08.414326192Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-08-25T14:53:08.414334068Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-08-25T14:53:08.414351683Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-08-25T14:53:08.414359680Z    -> 0.0002s
2025-08-25T14:53:08.414367485Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-08-25T14:53:08.414375431Z 
2025-08-25T14:53:08.414383267Z Migrating to AddPreviewToModelFile (20250520111046)
2025-08-25T14:53:08.414391333Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-08-25T14:53:08.414399931Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-08-25T14:53:08.414408448Z    -> 0.0010s
2025-08-25T14:53:08.414416544Z == 20250520111046 AddPreviewToModelFile: migrated (0.0018s) ===================
2025-08-25T14:53:08.414424500Z 
2025-08-25T14:53:08.414432416Z Migrating to CreateAltchaSolutions (20250609210440)
2025-08-25T14:53:08.414440262Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-08-25T14:53:08.414448218Z -- create_table(:altcha_solutions)
2025-08-25T14:53:08.414456264Z    -> 0.0004s
2025-08-25T14:53:08.414464661Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-08-25T14:53:08.414473038Z    -> 0.0002s
2025-08-25T14:53:08.414483830Z == 20250609210440 CreateAltchaSolutions: migrated (0.0017s) ===================
2025-08-25T14:53:08.414491886Z 
2025-08-25T14:53:08.414499982Z Migrating to AddIndexableFields (20250620141805)
2025-08-25T14:53:08.414508269Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-08-25T14:53:08.414516525Z -- change_table(:models)
2025-08-25T14:53:08.414524451Z    -> 0.0024s
2025-08-25T14:53:08.414532758Z -- change_table(:creators)
2025-08-25T14:53:08.414540875Z    -> 0.0017s
2025-08-25T14:53:08.414548861Z -- change_table(:collections)
2025-08-25T14:53:08.414556887Z    -> 0.0017s
2025-08-25T14:53:08.414564692Z == 20250620141805 AddIndexableFields: migrated (0.0058s) ======================
2025-08-25T14:53:08.414572859Z 
2025-08-25T14:53:08.414581647Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-08-25T14:53:08.414590184Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-08-25T14:53:08.414598270Z -- change_column(:models, :indexable, :string)
2025-08-25T14:53:08.414606336Z    -> 0.0245s
2025-08-25T14:53:08.414614553Z -- change_column(:models, :ai_indexable, :string)
2025-08-25T14:53:08.414623260Z    -> 0.0213s
2025-08-25T14:53:08.414631457Z -- change_column(:creators, :indexable, :string)
2025-08-25T14:53:08.414640094Z    -> 0.0090s
2025-08-25T14:53:08.414657459Z -- change_column(:creators, :ai_indexable, :string)
2025-08-25T14:53:08.414665936Z    -> 0.0085s
2025-08-25T14:53:08.414673712Z -- change_column(:collections, :indexable, :string)
2025-08-25T14:53:08.414681608Z    -> 0.0500s
2025-08-25T14:53:08.414689434Z -- change_column(:collections, :ai_indexable, :string)
2025-08-25T14:53:08.414697340Z    -> 0.0126s
2025-08-25T14:53:08.414705195Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1263s) ======
2025-08-25T14:53:08.414713161Z 
2025-08-25T14:53:08.414720977Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-08-25T14:53:08.414729134Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-08-25T14:53:08.414737601Z -- change_table(:models)
2025-08-25T14:53:08.414745587Z    -> 0.0004s
2025-08-25T14:53:08.414753342Z -- change_table(:creators)
2025-08-25T14:53:08.414761088Z    -> 0.0003s
2025-08-25T14:53:08.414769114Z -- change_table(:collections)
2025-08-25T14:53:08.414776860Z    -> 0.0003s
2025-08-25T14:53:08.414784706Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0009s) =================
2025-08-25T14:53:08.414792702Z 
2025-08-25T14:53:08.414801449Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-08-25T14:53:08.414809395Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-08-25T14:53:08.414817331Z -- change_table(:links)
2025-08-25T14:53:08.414825077Z    -> 0.0002s
2025-08-25T14:53:08.414832923Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-08-25T14:53:08.414840859Z 
2025-08-25T14:53:08.414848564Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-08-25T14:53:08.414856560Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-08-25T14:53:08.414864546Z -- add_column(:links, :synced_at, :datetime)
2025-08-25T14:53:08.414872412Z    -> 0.0010s
2025-08-25T14:53:08.414880278Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0010s) ======================
2025-08-25T14:53:08.414888204Z 
2025-08-25T14:53:08.414895879Z Migrating to CreateFaspClientProviders (20250806142734)
2025-08-25T14:53:08.414903846Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-08-25T14:53:08.414911792Z -- create_table(:fasp_client_providers)
2025-08-25T14:53:08.414919788Z    -> 0.0443s
2025-08-25T14:53:08.414927623Z == 20250806142734 CreateFaspClientProviders: migrated (0.0443s) ===============
2025-08-25T14:53:08.414935589Z 
2025-08-25T14:53:08.474493811Z s6-rc: info: service init-manyfold-config successfully started
2025-08-25T14:53:08.474854929Z s6-rc: info: service init-config-end: starting
2025-08-25T14:53:08.477306205Z s6-rc: info: service init-config-end successfully started
2025-08-25T14:53:08.477636110Z s6-rc: info: service init-mods: starting
2025-08-25T14:53:08.479583612Z s6-rc: info: service init-mods successfully started
2025-08-25T14:53:08.479975541Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-08-25T14:53:08.489736911Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-08-25T14:53:08.489986955Z s6-rc: info: service init-mods-package-install: starting
2025-08-25T14:53:08.501965941Z [pkg-install-init] **** Installing all mod packages ****
2025-08-25T14:53:08.512552563Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-08-25T14:53:08.592845174Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-08-25T14:53:08.917025271Z (1/1) Installing redis (8.0.3-r0)
2025-08-25T14:53:08.926869147Z Executing redis-8.0.3-r0.pre-install
2025-08-25T14:53:08.969319182Z Executing redis-8.0.3-r0.post-install
2025-08-25T14:53:08.978407917Z Executing busybox-1.37.0-r19.trigger
2025-08-25T14:53:08.993165759Z OK: 427 MiB in 116 packages
2025-08-25T14:53:09.083677883Z s6-rc: info: service init-mods-package-install successfully started
2025-08-25T14:53:09.083809508Z s6-rc: info: service init-mods-end: starting
2025-08-25T14:53:09.085679695Z s6-rc: info: service init-mods-end successfully started
2025-08-25T14:53:09.085880780Z s6-rc: info: service init-custom-files: starting
2025-08-25T14:53:09.092850206Z [custom-init] No custom files found, skipping...
2025-08-25T14:53:09.093399032Z s6-rc: info: service init-custom-files successfully started
2025-08-25T14:53:09.093648143Z s6-rc: info: service init-services: starting
2025-08-25T14:53:09.095293467Z s6-rc: info: service init-services successfully started
2025-08-25T14:53:09.095365703Z s6-rc: info: service svc-mod-universal-redis: starting
2025-08-25T14:53:09.095672701Z s6-rc: info: service svc-manyfold: starting
2025-08-25T14:53:09.095780719Z s6-rc: info: service svc-cron: starting
2025-08-25T14:53:09.098041361Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-08-25T14:53:09.098618133Z s6-rc: info: service svc-cron successfully started
2025-08-25T14:53:09.112195228Z 279:C 25 Aug 2025 14:53:09.112 # 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-08-25T14:53:09.112220939Z 279:C 25 Aug 2025 14:53:09.112 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-08-25T14:53:09.112230769Z 279:C 25 Aug 2025 14:53:09.112 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=279, just started
2025-08-25T14:53:09.112256942Z 279:C 25 Aug 2025 14:53:09.112 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-08-25T14:53:09.113210743Z 279:M 25 Aug 2025 14:53:09.113 * monotonic clock: POSIX clock_gettime
2025-08-25T14:53:09.113844249Z 279:M 25 Aug 2025 14:53:09.113 * Running mode=standalone, port=6379.
2025-08-25T14:53:09.114316670Z 279:M 25 Aug 2025 14:53:09.114 * Server initialized
2025-08-25T14:53:09.114337422Z 279:M 25 Aug 2025 14:53:09.114 * Ready to accept connections tcp
2025-08-25T14:53:09.285249844Z 14:53:09 rails.1              | started with pid 301
2025-08-25T14:53:09.285291558Z 14:53:09 default_worker.1     | started with pid 302
2025-08-25T14:53:09.285303171Z 14:53:09 performance_worker.1 | started with pid 303
2025-08-25T14:53:10.500625670Z 14:53:10 rails.1              | `/root` is not writable.
2025-08-25T14:53:10.500663646Z 14:53:10 rails.1              | Bundler will use `/tmp/bundler20250825-301-spkesf301' as your home directory temporarily.
2025-08-25T14:53:10.996518880Z 14:53:10 performance_worker.1 | `/root` is not writable.
2025-08-25T14:53:10.996554382Z 14:53:10 performance_worker.1 | Bundler will use `/tmp/bundler20250825-303-ma1tf303' as your home directory temporarily.
2025-08-25T14:53:10.997325915Z 14:53:10 default_worker.1     | `/root` is not writable.
2025-08-25T14:53:10.997359122Z 14:53:10 default_worker.1     | Bundler will use `/tmp/bundler20250825-302-ouptzb302' as your home directory temporarily.
2025-08-25T14:53:11.512826285Z 14:53:11 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-08-25T14:53:11.512866075Z 14:53:11 rails.1              | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-25T14:53:11.512875684Z 14:53:11 rails.1              | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-25T14:53:11.804299859Z 14:53:11 rails.1              | => Booting Puma
2025-08-25T14:53:11.804340320Z 14:53:11 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-08-25T14:53:11.804380361Z 14:53:11 rails.1              | => Run `bin/rails server --help` for more startup options
2025-08-25T14:53:11.979102475Z 14:53:11 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-08-25T14:53:11.979141384Z 14:53:11 performance_worker.1 | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-25T14:53:11.979151694Z 14:53:11 performance_worker.1 | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-25T14:53:11.985101417Z 14:53:11 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-08-25T14:53:11.985136167Z 14:53:11 default_worker.1     | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-25T14:53:11.985200557Z 14:53:11 default_worker.1     | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-25T14:53:12.426130559Z 14:53:12 default_worker.1     | Server: a6f7bb3b8edc, Context: rails, Role: web, data: {cpu: {one_min: 2.53, five_min: 1.64, fifteen_min: 1.53}, memory: 0.18061312e9, disk: {available: 851532578816, total: 938656133120, used: 87123554304}}
2025-08-25T14:53:12.463461264Z 14:53:12 performance_worker.1 | Server: a6f7bb3b8edc, Context: rails, Role: web, data: {cpu: {one_min: 2.53, five_min: 1.64, fifteen_min: 1.53}, memory: 0.178323456e9, disk: {available: 851532451840, total: 938656133120, used: 87123681280}}
2025-08-25T14:53:14.452768360Z 14:53:14 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:14.453834858Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.453Z pid=302 tid=22e: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-25T14:53:14.464066224Z 14:53:14 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:14.465401774Z 14:53:14 performance_worker.1 | INFO  2025-08-25T14:53:14.465Z pid=303 tid=22f: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-25T14:53:14.512214686Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.511Z pid=302 tid=22e: Booted Rails 8.0.2.1 application in production environment
2025-08-25T14:53:14.512332433Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.511Z pid=302 tid=22e: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-08-25T14:53:14.512484369Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.511Z pid=302 tid=22e: See LICENSE and the LGPL-3.0 for licensing details.
2025-08-25T14:53:14.512576083Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.511Z pid=302 tid=22e: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-08-25T14:53:14.515213035Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.514Z pid=302 tid=22e: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-08-25T14:53:14.522816398Z 14:53:14 performance_worker.1 | INFO  2025-08-25T14:53:14.522Z pid=303 tid=22f: Booted Rails 8.0.2.1 application in production environment
2025-08-25T14:53:14.522977843Z 14:53:14 performance_worker.1 | INFO  2025-08-25T14:53:14.522Z pid=303 tid=22f: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-08-25T14:53:14.523083746Z 14:53:14 performance_worker.1 | INFO  2025-08-25T14:53:14.522Z pid=303 tid=22f: See LICENSE and the LGPL-3.0 for licensing details.
2025-08-25T14:53:14.523269540Z 14:53:14 performance_worker.1 | INFO  2025-08-25T14:53:14.522Z pid=303 tid=22f: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-08-25T14:53:14.525815267Z 14:53:14 performance_worker.1 | INFO  2025-08-25T14:53:14.525Z pid=303 tid=22f: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-08-25T14:53:14.603330675Z 14:53:14 rails.1              | Server: a6f7bb3b8edc, Context: rails, Role: web, data: {cpu: {one_min: 2.53, five_min: 1.64, fifteen_min: 1.53}, memory: 0.17354752e9, disk: {available: 851533754368, total: 938656133120, used: 87122378752}}
2025-08-25T14:53:14.603407009Z 14:53:14 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:14.609598990Z 14:53:14 rails.1              | INFO  2025-08-25T14:53:14.444Z pid=301 tid=2cl: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-25T14:53:14.609698891Z 14:53:14 rails.1              | INFO  2025-08-25T14:53:14.449Z pid=301 tid=2cl: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-08-25T14:53:14.609713350Z 14:53:14 rails.1              | INFO  2025-08-25T14:53:14.451Z pid=301 tid=2cl: Cron Jobs - added job with name clear-downloads in the namespace default
2025-08-25T14:53:14.609768671Z 14:53:14 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: f9c455ed-cc67-4445-a76c-291c22a55a6c) to Sidekiq(upgrade)
2025-08-25T14:53:14.609826568Z 14:53:14 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: c1fd51bd-7048-4fb9-9d40-b64874242fc0) to Sidekiq(upgrade)
2025-08-25T14:53:14.609855045Z 14:53:14 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 23214035-994b-454c-9bf4-bf33ae7a71b6) to Sidekiq(upgrade)
2025-08-25T14:53:14.609900327Z 14:53:14 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: c5fc0c1a-885c-4c46-a4c9-94c31b52ece4) to Sidekiq(upgrade)
2025-08-25T14:53:14.609940758Z 14:53:14 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 6b933bbf-edd3-420a-bd39-5e5be632cf43) to Sidekiq(upgrade)
2025-08-25T14:53:14.609988494Z 14:53:14 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: 53c13a3d-3edb-4c1c-8509-64a817801d2c) to Sidekiq(upgrade)
2025-08-25T14:53:14.610037423Z 14:53:14 rails.1              | [301] Puma starting in cluster mode...
2025-08-25T14:53:14.610078495Z 14:53:14 rails.1              | [301] * Puma version: 6.6.1 ("Return to Forever")
2025-08-25T14:53:14.610130580Z 14:53:14 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-08-25T14:53:14.610173787Z 14:53:14 rails.1              | [301] *  Min threads: 4
2025-08-25T14:53:14.610220461Z 14:53:14 rails.1              | [301] *  Max threads: 16
2025-08-25T14:53:14.610266133Z 14:53:14 rails.1              | [301] *  Environment: production
2025-08-25T14:53:14.610313318Z 14:53:14 rails.1              | [301] *   Master PID: 301
2025-08-25T14:53:14.610355884Z 14:53:14 rails.1              | [301] *      Workers: 4
2025-08-25T14:53:14.610402057Z 14:53:14 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-08-25T14:53:14.610447398Z 14:53:14 rails.1              | [301] * Preloading application
2025-08-25T14:53:14.610506658Z 14:53:14 rails.1              | [301] * Listening on http://[::]:3214
2025-08-25T14:53:14.610549614Z 14:53:14 rails.1              | [301] Use Ctrl-C to stop
2025-08-25T14:53:14.632395953Z 14:53:14 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-08-25T14:53:14.632421885Z 14:53:14 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.01s, phase: 0
2025-08-25T14:53:14.632546817Z 14:53:14 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-08-25T14:53:14.634135286Z 14:53:14 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-08-25T14:53:14.781451053Z 14:53:14 performance_worker.1 | Server: a6f7bb3b8edc, Context: sidekiq, Role: background, data: {cpu: {one_min: 2.89, five_min: 1.73, fifteen_min: 1.56}, memory: 0.220672e9, disk: {available: 851525091328, total: 938656133120, used: 87131041792}}
2025-08-25T14:53:14.783886007Z 14:53:14 default_worker.1     | Server: a6f7bb3b8edc, Context: sidekiq, Role: background, data: {cpu: {one_min: 2.89, five_min: 1.73, fifteen_min: 1.56}, memory: 0.226103296e9, disk: {available: 851525091328, total: 938656133120, used: 87131041792}}
2025-08-25T14:53:14.864237547Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.784Z pid=302 tid=gri jid=d43af06e2757be43f5726429 class=Upgrade::FixNilFileSizeValues: start
2025-08-25T14:53:14.867165704Z 14:53:14 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f9c455ed-cc67-4445-a76c-291c22a55a6c] Performing Upgrade::FixNilFileSizeValues (Job ID: f9c455ed-cc67-4445-a76c-291c22a55a6c) from Sidekiq(upgrade) enqueued at 2025-08-25T14:53:14.463519883Z
2025-08-25T14:53:14.867700381Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.863Z pid=302 tid=gra jid=9a63179dcbfd0d95c6652f62 class=Upgrade::BackfillDataPackages: start
2025-08-25T14:53:14.874050931Z 14:53:14 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [c1fd51bd-7048-4fb9-9d40-b64874242fc0] Performing Upgrade::BackfillDataPackages (Job ID: c1fd51bd-7048-4fb9-9d40-b64874242fc0) from Sidekiq(upgrade) enqueued at 2025-08-25T14:53:14.464530689Z
2025-08-25T14:53:14.885382994Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.863Z pid=302 tid=h7y jid=bfff48e222dd1fec0b879045 class=Upgrade::DisambiguateUsernamesJob: start
2025-08-25T14:53:14.886346595Z 14:53:14 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [23214035-994b-454c-9bf4-bf33ae7a71b6] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 23214035-994b-454c-9bf4-bf33ae7a71b6) from Sidekiq(upgrade) enqueued at 2025-08-25T14:53:14.465250208Z
2025-08-25T14:53:14.887236948Z 14:53:14 default_worker.1     | INFO  2025-08-25T14:53:14.867Z pid=302 tid=h7i jid=c3b7ecbef1554cfbe874ca0c class=Upgrade::UpdateActorsJob: start
2025-08-25T14:53:14.892749300Z 14:53:14 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [c5fc0c1a-885c-4c46-a4c9-94c31b52ece4] Performing Upgrade::UpdateActorsJob (Job ID: c5fc0c1a-885c-4c46-a4c9-94c31b52ece4) from Sidekiq(upgrade) enqueued at 2025-08-25T14:53:14.465868163Z
2025-08-25T14:53:14.902277961Z 14:53:14 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [23214035-994b-454c-9bf4-bf33ae7a71b6] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:14.906828095Z 14:53:14 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f9c455ed-cc67-4445-a76c-291c22a55a6c] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:14.975725115Z 14:53:14 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [c5fc0c1a-885c-4c46-a4c9-94c31b52ece4] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:15.132980931Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-08-25T14:53:15.134293294Z s6-rc: info: service svc-manyfold successfully started
2025-08-25T14:53:15.134623920Z s6-rc: info: service legacy-services: starting
2025-08-25T14:53:15.146309605Z s6-rc: info: service legacy-services successfully started
2025-08-25T14:53:15.146386320Z s6-rc: info: service ci-service-check: starting
2025-08-25T14:53:15.147011840Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f9c455ed-cc67-4445-a76c-291c22a55a6c] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-08-25T14:53:15.150160511Z [ls.io-init] done.
2025-08-25T14:53:15.150806863Z s6-rc: info: service ci-service-check successfully started
2025-08-25T14:53:15.164862291Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f9c455ed-cc67-4445-a76c-291c22a55a6c] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.111
2025-08-25T14:53:15.208139241Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [c1fd51bd-7048-4fb9-9d40-b64874242fc0] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:15.242968999Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [23214035-994b-454c-9bf4-bf33ae7a71b6] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 23214035-994b-454c-9bf4-bf33ae7a71b6) from Sidekiq(upgrade) in 356.15ms
2025-08-25T14:53:15.243410338Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f9c455ed-cc67-4445-a76c-291c22a55a6c] Performed Upgrade::FixNilFileSizeValues (Job ID: f9c455ed-cc67-4445-a76c-291c22a55a6c) from Sidekiq(upgrade) in 376.43ms
2025-08-25T14:53:15.244167884Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [c5fc0c1a-885c-4c46-a4c9-94c31b52ece4] Performed Upgrade::UpdateActorsJob (Job ID: c5fc0c1a-885c-4c46-a4c9-94c31b52ece4) from Sidekiq(upgrade) in 351.44ms
2025-08-25T14:53:15.252037994Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [c1fd51bd-7048-4fb9-9d40-b64874242fc0] Performed Upgrade::BackfillDataPackages (Job ID: c1fd51bd-7048-4fb9-9d40-b64874242fc0) from Sidekiq(upgrade) in 382.69ms
2025-08-25T14:53:15.253224835Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.243Z pid=302 tid=h7y jid=bfff48e222dd1fec0b879045 class=Upgrade::DisambiguateUsernamesJob elapsed=0.38: done
2025-08-25T14:53:15.253320217Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.251Z pid=302 tid=gri jid=d43af06e2757be43f5726429 class=Upgrade::FixNilFileSizeValues elapsed=0.467: done
2025-08-25T14:53:15.253747247Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.253Z pid=302 tid=h7y jid=68dfc22f006d2d1c1af1a755 class=Upgrade::FixParentCollections: start
2025-08-25T14:53:15.254298687Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [6b933bbf-edd3-420a-bd39-5e5be632cf43] Performing Upgrade::FixParentCollections (Job ID: 6b933bbf-edd3-420a-bd39-5e5be632cf43) from Sidekiq(upgrade) enqueued at 2025-08-25T14:53:14.466473392Z
2025-08-25T14:53:15.254618241Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.253Z pid=302 tid=gra jid=9a63179dcbfd0d95c6652f62 class=Upgrade::BackfillDataPackages elapsed=0.39: done
2025-08-25T14:53:15.254650506Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.252Z pid=302 tid=h7i jid=c3b7ecbef1554cfbe874ca0c class=Upgrade::UpdateActorsJob elapsed=0.386: done
2025-08-25T14:53:15.255041864Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.253Z pid=302 tid=gri jid=1d3d9570ffcae52d9c7ac13f class=Upgrade::PruneOrphanedProblems: start
2025-08-25T14:53:15.255516680Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [53c13a3d-3edb-4c1c-8509-64a817801d2c] Performing Upgrade::PruneOrphanedProblems (Job ID: 53c13a3d-3edb-4c1c-8509-64a817801d2c) from Sidekiq(upgrade) enqueued at 2025-08-25T14:53:14.467142850Z
2025-08-25T14:53:15.272705900Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [6b933bbf-edd3-420a-bd39-5e5be632cf43] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:15.353145146Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [53c13a3d-3edb-4c1c-8509-64a817801d2c] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-25T14:53:15.501891484Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [53c13a3d-3edb-4c1c-8509-64a817801d2c] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-08-25T14:53:15.502334366Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [53c13a3d-3edb-4c1c-8509-64a817801d2c] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.059
2025-08-25T14:53:15.502422503Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [6b933bbf-edd3-420a-bd39-5e5be632cf43] Performed Upgrade::FixParentCollections (Job ID: 6b933bbf-edd3-420a-bd39-5e5be632cf43) from Sidekiq(upgrade) in 247.66ms
2025-08-25T14:53:15.521360455Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.521Z pid=302 tid=h7y jid=68dfc22f006d2d1c1af1a755 class=Upgrade::FixParentCollections elapsed=0.268: done
2025-08-25T14:53:15.527057188Z 14:53:15 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [53c13a3d-3edb-4c1c-8509-64a817801d2c] Performed Upgrade::PruneOrphanedProblems (Job ID: 53c13a3d-3edb-4c1c-8509-64a817801d2c) from Sidekiq(upgrade) in 267.77ms
2025-08-25T14:53:15.533545165Z 14:53:15 default_worker.1     | INFO  2025-08-25T14:53:15.533Z pid=302 tid=gri jid=1d3d9570ffcae52d9c7ac13f class=Upgrade::PruneOrphanedProblems elapsed=0.279: done
2025-08-25T14:53:39.304816656Z 14:53:39 rails.1              | [42d1694b-37cb-4c64-8cd7-f5073b0e41db] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1390,"duration":23.69,"view":0.0,"db":5.12,"@timestamp":"2025-08-25T14:53:39.303Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-08-25T14:53:40.332826777Z 14:53:40 rails.1              | [6f56a09f-2f91-4748-9dc3-de959d41ccff] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":122745,"duration":978.3,"view":0.0,"db":24.54,"location":"http://172.17.0.4:3214/","@timestamp":"2025-08-25T14:53:40.332Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-08-25T14:53:40.374427661Z 14:53:40 rails.1              | [9569372f-936b-40b4-9c96-97dfee0e3200] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1067,"duration":22.05,"view":0.0,"db":0.51,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-08-25T14:53:40.361Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-08-25T14:53:41.093018411Z 14:53:41 rails.1              | [dea97513-fadd-4e0a-b421-ea95a40baeab] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":23440,"duration":695.91,"view":563.18,"db":68.48,"@timestamp":"2025-08-25T14:53:41.092Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-08-25T14:53:41.142712395Z 14:53:41 rails.1              | [f1e2dfe4-0c96-475e-affb-02018e28884c] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1183,"duration":16.02,"view":0.0,"db":2.33,"@timestamp":"2025-08-25T14:53:41.141Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-08-25T14:53:41.475472403Z 14:53:41 rails.1              | [e3557497-96c2-4901-bd3c-0e09f1209f7f] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14513,"duration":225.03,"view":0.0,"db":1.55,"location":"http://172.17.0.4:3214/","@timestamp":"2025-08-25T14:53:41.440Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-08-25T14:53:41.504666550Z 14:53:41 rails.1              | [6f2bd7a2-c827-4590-a442-961095d8abaf] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1090,"duration":21.99,"view":0.0,"db":1.89,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-08-25T14:53:41.504Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-08-25T14:53:41.841294959Z 14:53:41 rails.1              | [f0fb9e1c-8bae-483d-8b6a-ddcfe1506fba] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":23649,"duration":316.51,"view":203.7,"db":1.05,"@timestamp":"2025-08-25T14:53:41.835Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}