2025-09-17T15:46:45.379821854Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-09-17T15:46:45.379854309Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-09-17T15:46:45.430957593Z [mod-init] Running Docker Modification Logic
2025-09-17T15:46:45.670616513Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-09-17T15:46:46.407727828Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-09-17T15:46:46.779663989Z [mod-init] Installing linuxserver/mods:universal-redis
2025-09-17T15:46:46.805246092Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-09-17T15:46:46.806169572Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-09-17T15:46:46.828899221Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-09-17T15:46:46.832757941Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-09-17T15:46:46.833022364Z s6-rc: info: service fix-attrs: starting
2025-09-17T15:46:46.833142095Z s6-rc: info: service init-migrations: starting
2025-09-17T15:46:46.833321536Z s6-rc: info: service init-envfile: starting
2025-09-17T15:46:46.840273765Z [migrations] started
2025-09-17T15:46:46.840323736Z [migrations] no migrations found
2025-09-17T15:46:46.840670013Z s6-rc: info: service fix-attrs successfully started
2025-09-17T15:46:46.840847631Z s6-rc: info: service legacy-cont-init: starting
2025-09-17T15:46:46.841002523Z s6-rc: info: service init-migrations successfully started
2025-09-17T15:46:46.841204780Z s6-rc: info: service init-adduser: starting
2025-09-17T15:46:46.842542925Z s6-rc: info: service init-envfile successfully started
2025-09-17T15:46:46.847709498Z s6-rc: info: service legacy-cont-init successfully started
2025-09-17T15:46:46.866793447Z usermod: no changes
2025-09-17T15:46:46.874314532Z ───────────────────────────────────────
2025-09-17T15:46:46.874340725Z 
2025-09-17T15:46:46.874345003Z       ██╗     ███████╗██╗ ██████╗
2025-09-17T15:46:46.874349442Z       ██║     ██╔════╝██║██╔═══██╗
2025-09-17T15:46:46.874353200Z       ██║     ███████╗██║██║   ██║
2025-09-17T15:46:46.874357198Z       ██║     ╚════██║██║██║   ██║
2025-09-17T15:46:46.874361146Z       ███████╗███████║██║╚██████╔╝
2025-09-17T15:46:46.874364863Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-09-17T15:46:46.874369152Z 
2025-09-17T15:46:46.874373300Z    Brought to you by linuxserver.io
2025-09-17T15:46:46.874401567Z ───────────────────────────────────────
2025-09-17T15:46:46.874664837Z 
2025-09-17T15:46:46.874682062Z To support LSIO projects visit:
2025-09-17T15:46:46.874686240Z https://www.linuxserver.io/donate/
2025-09-17T15:46:46.874690018Z 
2025-09-17T15:46:46.874693896Z ───────────────────────────────────────
2025-09-17T15:46:46.874698545Z GID/UID
2025-09-17T15:46:46.874702253Z ───────────────────────────────────────
2025-09-17T15:46:46.880728076Z 
2025-09-17T15:46:46.880738638Z User UID:    911
2025-09-17T15:46:46.880742465Z User GID:    911
2025-09-17T15:46:46.880746113Z ───────────────────────────────────────
2025-09-17T15:46:46.883535920Z Linuxserver.io version: v0.123.1-ls103
2025-09-17T15:46:46.884004845Z Build-date: 2025-09-17T15:34:22+00:00
2025-09-17T15:46:46.884037039Z ───────────────────────────────────────
2025-09-17T15:46:46.884047621Z     
2025-09-17T15:46:46.903529791Z s6-rc: info: service init-adduser successfully started
2025-09-17T15:46:46.903730245Z s6-rc: info: service init-device-perms: starting
2025-09-17T15:46:46.911310078Z s6-rc: info: service init-device-perms successfully started
2025-09-17T15:46:46.911557756Z s6-rc: info: service init-os-end: starting
2025-09-17T15:46:46.913242990Z s6-rc: info: service init-os-end successfully started
2025-09-17T15:46:46.913483955Z s6-rc: info: service init-manyfold-config: starting
2025-09-17T15:46:46.913621001Z s6-rc: info: service init-config: starting
2025-09-17T15:46:46.915061782Z s6-rc: info: service init-config successfully started
2025-09-17T15:46:46.915168527Z s6-rc: info: service init-crontab-config: starting
2025-09-17T15:46:46.925259237Z s6-rc: info: service init-crontab-config successfully started
2025-09-17T15:46:46.947190138Z **** Running Manyfold database init. ****
2025-09-17T15:46:49.269262583Z `/root` is not writable.
2025-09-17T15:46:49.269443979Z Bundler will use `/tmp/bundler20250917-173-9gefph173' as your home directory temporarily.
2025-09-17T15:46:52.083714069Z /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-17T15:46:52.083760663Z You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-17T15:46:52.083771224Z Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-17T15:46:55.977686695Z Server: 8c71e77ca183, Context: rails, Role: web, data: {cpu: {one_min: 2.3, five_min: 1.53, fifteen_min: 1.22}, memory: 0.226709504e9, disk: {available: 848674058240, total: 938656133120, used: 89982074880}}
2025-09-17T15:46:55.977735253Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-09-17T15:46:55.977745173Z INFO  2025-09-17T15:46:54.022Z pid=173 tid=28l: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-17T15:46:55.977754892Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-09-17T15:46:55.977763670Z Migrating to CreateLibraries (20210130201037)
2025-09-17T15:46:55.977771766Z == 20210130201037 CreateLibraries: migrating ==================================
2025-09-17T15:46:55.977779923Z -- create_table(:libraries)
2025-09-17T15:46:55.977787839Z    -> 0.0028s
2025-09-17T15:46:55.977795875Z == 20210130201037 CreateLibraries: migrated (0.0029s) =========================
2025-09-17T15:46:55.977803811Z 
2025-09-17T15:46:55.977811536Z Migrating to CreateModels (20210130203243)
2025-09-17T15:46:55.977819412Z == 20210130203243 CreateModels: migrating =====================================
2025-09-17T15:46:55.977827338Z -- create_table(:models)
2025-09-17T15:46:55.977835515Z    -> 0.0010s
2025-09-17T15:46:55.977843641Z == 20210130203243 CreateModels: migrated (0.0010s) ============================
2025-09-17T15:46:55.977851747Z 
2025-09-17T15:46:55.977859443Z Migrating to CreateParts (20210205230918)
2025-09-17T15:46:55.977867539Z == 20210205230918 CreateParts: migrating ======================================
2025-09-17T15:46:55.977876367Z -- create_table(:parts)
2025-09-17T15:46:55.977884143Z    -> 0.0043s
2025-09-17T15:46:55.977892139Z == 20210205230918 CreateParts: migrated (0.0043s) =============================
2025-09-17T15:46:55.977900265Z 
2025-09-17T15:46:55.977908301Z Migrating to AddFieldsToParts (20210210153744)
2025-09-17T15:46:55.977916428Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-09-17T15:46:55.977925005Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-09-17T15:46:55.977933322Z    -> 0.0008s
2025-09-17T15:46:55.977941388Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-09-17T15:46:55.977949514Z    -> 0.0003s
2025-09-17T15:46:55.977957490Z == 20210210153744 AddFieldsToParts: migrated (0.0012s) ========================
2025-09-17T15:46:55.977965386Z 
2025-09-17T15:46:55.977973142Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-09-17T15:46:55.977981489Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-09-17T15:46:55.978019705Z -- create_table(:tags, {id: :integer})
2025-09-17T15:46:55.978027852Z    -> 0.0044s
2025-09-17T15:46:55.978035848Z -- create_table(:taggings, {id: :integer})
2025-09-17T15:46:55.978043974Z    -> 0.0019s
2025-09-17T15:46:55.978051750Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-17T15:46:55.978060157Z    -> 0.0002s
2025-09-17T15:46:55.978069866Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-17T15:46:55.978078654Z    -> 0.0030s
2025-09-17T15:46:55.978086450Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0097s) ===============
2025-09-17T15:46:55.978094616Z 
2025-09-17T15:46:55.978102763Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-09-17T15:46:55.978111210Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-09-17T15:46:55.978119206Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-09-17T15:46:55.978127272Z    -> 0.0004s
2025-09-17T15:46:55.978135058Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-17T15:46:55.978143555Z    -> 0.0005s
2025-09-17T15:46:55.978151290Z -- remove_foreign_key(:taggings, :tags)
2025-09-17T15:46:55.978159477Z    -> 0.2018s
2025-09-17T15:46:55.978167202Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-17T15:46:55.978175219Z    -> 0.0145s
2025-09-17T15:46:55.978183105Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-09-17T15:46:55.978193265Z    -> 0.0002s
2025-09-17T15:46:55.978201041Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-09-17T15:46:55.978209468Z    -> 0.0048s
2025-09-17T15:46:55.978217374Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-09-17T15:46:55.978226392Z    -> 0.0703s
2025-09-17T15:46:55.978234157Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3232s) =================
2025-09-17T15:46:55.978242113Z 
2025-09-17T15:46:55.978249809Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-09-17T15:46:55.978257785Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-09-17T15:46:55.978266031Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-09-17T15:46:55.978274068Z    -> 0.0360s
2025-09-17T15:46:55.978282304Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1155s) ===========
2025-09-17T15:46:55.978290691Z 
2025-09-17T15:46:55.978298767Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-09-17T15:46:55.978318988Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-09-17T15:46:55.978327165Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-17T15:46:55.978335582Z    -> 0.0002s
2025-09-17T15:46:55.978343618Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-09-17T15:46:55.978352205Z 
2025-09-17T15:46:55.978359810Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-09-17T15:46:55.978367766Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-09-17T15:46:55.978375702Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0006s) ==============
2025-09-17T15:46:55.978383668Z 
2025-09-17T15:46:55.978391314Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-09-17T15:46:55.978399190Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-09-17T15:46:55.978407667Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-17T15:46:55.978415993Z    -> 0.0077s
2025-09-17T15:46:55.978423799Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-17T15:46:55.978431855Z    -> 0.0002s
2025-09-17T15:46:55.978439611Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-17T15:46:55.978447908Z    -> 0.0057s
2025-09-17T15:46:55.978455673Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-17T15:46:55.978463720Z    -> 0.0012s
2025-09-17T15:46:55.978471756Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-17T15:46:55.978479942Z    -> 0.0004s
2025-09-17T15:46:55.978487698Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-17T15:46:55.978495824Z    -> 0.0002s
2025-09-17T15:46:55.978503590Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-17T15:46:55.978511666Z    -> 0.0042s
2025-09-17T15:46:55.978519402Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-17T15:46:55.978527488Z    -> 0.0001s
2025-09-17T15:46:55.978535214Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-17T15:46:55.978543300Z    -> 0.0005s
2025-09-17T15:46:55.978551075Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-17T15:46:55.978559392Z    -> 0.0001s
2025-09-17T15:46:55.978567138Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-17T15:46:55.978575374Z    -> 0.0005s
2025-09-17T15:46:55.978592920Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-17T15:46:55.978601206Z    -> 0.0001s
2025-09-17T15:46:55.978608962Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-17T15:46:55.978617219Z    -> 0.0016s
2025-09-17T15:46:55.978624924Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-17T15:46:55.978633171Z    -> 0.0002s
2025-09-17T15:46:55.978641007Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0230s) =============
2025-09-17T15:46:55.978648953Z 
2025-09-17T15:46:55.978657770Z Migrating to AddPreviewPartToModel (20210220204055)
2025-09-17T15:46:55.978665686Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-09-17T15:46:55.978674123Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-09-17T15:46:55.978682149Z    -> 0.2588s
2025-09-17T15:46:55.978689905Z == 20210220204055 AddPreviewPartToModel: migrated (0.2589s) ===================
2025-09-17T15:46:55.978698001Z 
2025-09-17T15:46:55.978705797Z Migrating to CreateCreators (20210225232756)
2025-09-17T15:46:55.978714024Z == 20210225232756 CreateCreators: migrating ===================================
2025-09-17T15:46:55.978722150Z -- create_table(:creators)
2025-09-17T15:46:55.978730146Z    -> 0.0130s
2025-09-17T15:46:55.978738082Z == 20210225232756 CreateCreators: migrated (0.0131s) ==========================
2025-09-17T15:46:55.978746890Z 
2025-09-17T15:46:55.978755377Z Migrating to AddCreatorToModels (20210225232841)
2025-09-17T15:46:55.978763533Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-09-17T15:46:55.978771720Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-09-17T15:46:55.978779676Z    -> 0.0494s
2025-09-17T15:46:55.978787431Z == 20210225232841 AddCreatorToModels: migrated (0.0494s) ======================
2025-09-17T15:46:55.978795588Z 
2025-09-17T15:46:55.978803674Z Migrating to CreateLinks (20210301230017)
2025-09-17T15:46:55.978811961Z == 20210301230017 CreateLinks: migrating ======================================
2025-09-17T15:46:55.978820087Z -- create_table(:links)
2025-09-17T15:46:55.978828093Z    -> 0.0008s
2025-09-17T15:46:55.978836230Z == 20210301230017 CreateLinks: migrated (0.0009s) =============================
2025-09-17T15:46:55.978844206Z 
2025-09-17T15:46:55.978851991Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-09-17T15:46:55.978860108Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-09-17T15:46:55.978878234Z -- remove_column(:creators, :thingiverse_user, :string)
2025-09-17T15:46:55.978887012Z    -> 0.0631s
2025-09-17T15:46:55.978894888Z -- remove_column(:creators, :cults3d_user, :string)
2025-09-17T15:46:55.978903044Z    -> 0.0041s
2025-09-17T15:46:55.978911421Z -- remove_column(:creators, :mmf_user, :string)
2025-09-17T15:46:55.978919437Z    -> 0.0132s
2025-09-17T15:46:55.978927173Z -- remove_column(:creators, :cgtrader_user, :string)
2025-09-17T15:46:55.978935039Z    -> 0.0035s
2025-09-17T15:46:55.978942774Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0859s) ==============
2025-09-17T15:46:55.978950750Z 
2025-09-17T15:46:55.978958346Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-09-17T15:46:55.978966211Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-09-17T15:46:55.978974097Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-09-17T15:46:55.978981963Z    -> 0.0542s
2025-09-17T15:46:55.978990089Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0542s) ==
2025-09-17T15:46:55.978997985Z 
2025-09-17T15:46:55.979005591Z Migrating to AddYUpToParts (20210318202638)
2025-09-17T15:46:55.979013447Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-09-17T15:46:55.979021322Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-09-17T15:46:55.979029188Z    -> 0.0144s
2025-09-17T15:46:55.979036904Z == 20210318202638 AddYUpToParts: migrated (0.0145s) ===========================
2025-09-17T15:46:55.979044770Z 
2025-09-17T15:46:55.979052375Z Migrating to CreateImages (20210321164508)
2025-09-17T15:46:55.979060171Z == 20210321164508 CreateImages: migrating =====================================
2025-09-17T15:46:55.979068167Z -- create_table(:images)
2025-09-17T15:46:55.979075912Z    -> 0.0152s
2025-09-17T15:46:55.979083638Z == 20210321164508 CreateImages: migrated (0.0152s) ============================
2025-09-17T15:46:55.979091504Z 
2025-09-17T15:46:55.979099049Z Migrating to CreateDelayedJobs (20210330215825)
2025-09-17T15:46:55.979106875Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-09-17T15:46:55.979114751Z -- create_table(:delayed_jobs)
2025-09-17T15:46:55.979122506Z    -> 0.0083s
2025-09-17T15:46:56.976339113Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-09-17T15:46:56.976379555Z    -> 0.0002s
2025-09-17T15:46:56.976389665Z == 20210330215825 CreateDelayedJobs: migrated (0.0086s) =======================
2025-09-17T15:46:56.976398042Z 
2025-09-17T15:46:56.976431099Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-09-17T15:46:56.976439375Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-09-17T15:46:56.976447772Z -- rename_table(:parts, :model_files)
2025-09-17T15:46:56.976455868Z    -> 0.0016s
2025-09-17T15:46:56.976464185Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-09-17T15:46:56.976472251Z    -> 0.0325s
2025-09-17T15:46:56.976480137Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0341s) =================
2025-09-17T15:46:56.976488174Z 
2025-09-17T15:46:56.976496170Z Migrating to RemoveImagesTable (20220106220519)
2025-09-17T15:46:56.976504156Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-09-17T15:46:56.976512222Z -- drop_table(:images)
2025-09-17T15:46:56.976520118Z    -> 0.0003s
2025-09-17T15:46:56.976528174Z == 20220106220519 RemoveImagesTable: migrated (0.0003s) =======================
2025-09-17T15:46:56.976536240Z 
2025-09-17T15:46:56.976544587Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-09-17T15:46:56.976552563Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-09-17T15:46:56.976560639Z -- table_exists?(:active_storage_blobs)
2025-09-17T15:46:56.976568585Z    -> 0.0001s
2025-09-17T15:46:56.976576431Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-09-17T15:46:56.976584467Z 
2025-09-17T15:46:56.976592323Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-09-17T15:46:56.976600339Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-09-17T15:46:56.976608706Z -- table_exists?(:active_storage_blobs)
2025-09-17T15:46:56.976617223Z    -> 0.0001s
2025-09-17T15:46:56.976625119Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-09-17T15:46:56.976633276Z 
2025-09-17T15:46:56.976640971Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-09-17T15:46:56.976649037Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-09-17T15:46:56.976657194Z -- table_exists?(:active_storage_blobs)
2025-09-17T15:46:56.976665110Z    -> 0.0001s
2025-09-17T15:46:56.976673026Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-09-17T15:46:56.976681152Z 
2025-09-17T15:46:56.976688908Z Migrating to DeviseCreateUsers (20220614210023)
2025-09-17T15:46:56.976696854Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-09-17T15:46:56.976704910Z -- create_table(:users)
2025-09-17T15:46:56.976712806Z    -> 0.0012s
2025-09-17T15:46:56.976730181Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-09-17T15:46:56.976738598Z    -> 0.0015s
2025-09-17T15:46:56.976746494Z == 20220614210023 DeviseCreateUsers: migrated (0.0027s) =======================
2025-09-17T15:46:56.976754600Z 
2025-09-17T15:46:56.976762376Z Migrating to AddUsernameToUsers (20220614211256)
2025-09-17T15:46:56.976770652Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-09-17T15:46:56.976780492Z -- add_column(:users, :username, :string, {null: false})
2025-09-17T15:46:56.976788629Z    -> 0.0216s
2025-09-17T15:46:56.976796695Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-09-17T15:46:56.976804881Z    -> 0.0001s
2025-09-17T15:46:56.976812757Z == 20220614211256 AddUsernameToUsers: migrated (0.0218s) ======================
2025-09-17T15:46:56.976820823Z 
2025-09-17T15:46:56.976828589Z Migrating to AddAdminToUsers (20220614213902)
2025-09-17T15:46:56.976836505Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-09-17T15:46:56.976844611Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-17T15:46:56.976852688Z    -> 0.0005s
2025-09-17T15:46:56.976860644Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-09-17T15:46:56.976868820Z 
2025-09-17T15:46:56.976876566Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-09-17T15:46:56.976886205Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-09-17T15:46:56.976896586Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-09-17T15:46:56.976908229Z    -> 0.0018s
2025-09-17T15:46:56.976917438Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0019s) =============
2025-09-17T15:46:56.976925885Z 
2025-09-17T15:46:56.976933731Z Migrating to CreateSettings (20220619174307)
2025-09-17T15:46:56.976941657Z == 20220619174307 CreateSettings: migrating ===================================
2025-09-17T15:46:56.976949703Z -- create_table(:settings)
2025-09-17T15:46:56.976957569Z    -> 0.0027s
2025-09-17T15:46:56.976965435Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-09-17T15:46:56.976973621Z    -> 0.0002s
2025-09-17T15:46:56.976981487Z == 20220619174307 CreateSettings: migrated (0.0030s) ==========================
2025-09-17T15:46:56.976989453Z 
2025-09-17T15:46:56.976997299Z Migrating to AddScaleFactorToModels (20220626152444)
2025-09-17T15:46:56.977005235Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-09-17T15:46:56.977035375Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-09-17T15:46:56.977045877Z    -> 0.0110s
2025-09-17T15:46:56.977055837Z == 20220626152444 AddScaleFactorToModels: migrated (0.0134s) ==================
2025-09-17T15:46:56.977066278Z 
2025-09-17T15:46:56.977076618Z Migrating to AddDigestToModelFiles (20220702202932)
2025-09-17T15:46:56.977086438Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-09-17T15:46:56.977099695Z -- add_column(:model_files, :digest, :string)
2025-09-17T15:46:56.977109635Z    -> 0.0025s
2025-09-17T15:46:56.977118473Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-09-17T15:46:56.977127110Z    -> 0.0002s
2025-09-17T15:46:56.977135327Z == 20220702202932 AddDigestToModelFiles: migrated (0.0047s) ===================
2025-09-17T15:46:56.977143383Z 
2025-09-17T15:46:56.977151259Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-09-17T15:46:56.977159505Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-09-17T15:46:56.977170998Z -- add_column(:users, :renderer_settings, :json, {default: {"grid_width" => 200, "grid_depth" => 200, "show_grid" => true, "enable_pan_zoom" => false, "background_colour" => "#000000", "object_colour" => "#ffffff", "render_style" => "original"}})
2025-09-17T15:46:56.977185177Z    -> 0.0010s
2025-09-17T15:46:56.977194877Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0014s) ==============
2025-09-17T15:46:56.977203063Z 
2025-09-17T15:46:56.977210809Z Migrating to CreateProblems (20221210001132)
2025-09-17T15:46:56.977218735Z == 20221210001132 CreateProblems: migrating ===================================
2025-09-17T15:46:56.977226961Z -- create_table(:problems)
2025-09-17T15:46:56.977235418Z    -> 0.0009s
2025-09-17T15:46:56.977245328Z == 20221210001132 CreateProblems: migrated (0.0012s) ==========================
2025-09-17T15:46:56.977255418Z 
2025-09-17T15:46:56.977264346Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-09-17T15:46:56.977272423Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-09-17T15:46:56.977280429Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0168s) ========
2025-09-17T15:46:56.977288415Z 
2025-09-17T15:46:56.977296110Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-09-17T15:46:56.977304026Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-09-17T15:46:56.977312413Z -- create_table(:favorites, {force: true})
2025-09-17T15:46:56.977320319Z    -> 0.0044s
2025-09-17T15:46:56.977341923Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-09-17T15:46:56.977352754Z    -> 0.0001s
2025-09-17T15:46:56.977362644Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-09-17T15:46:56.977373206Z    -> 0.0001s
2025-09-17T15:46:56.977383286Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-09-17T15:46:56.977395651Z    -> 0.0001s
2025-09-17T15:46:56.977405691Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0053s) ================
2025-09-17T15:46:56.977415882Z 
2025-09-17T15:46:56.977424058Z Migrating to MovePrintedToFavorites (20221220223040)
2025-09-17T15:46:56.977432024Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-09-17T15:46:56.977440040Z == 20221220223040 MovePrintedToFavorites: migrated (0.3298s) ==================
2025-09-17T15:46:56.977448036Z 
2025-09-17T15:46:56.977455762Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-09-17T15:46:56.977463748Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-09-17T15:46:56.977471864Z -- remove_column(:model_files, :printed, :boolean)
2025-09-17T15:46:56.977479770Z    -> 0.0311s
2025-09-17T15:46:56.977487646Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0315s) ===============
2025-09-17T15:46:56.977495652Z 
2025-09-17T15:46:56.977503358Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-09-17T15:46:56.977512486Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-09-17T15:46:56.977520863Z -- add_column(:models, :notes, :text)
2025-09-17T15:46:56.977528799Z    -> 0.0014s
2025-09-17T15:46:56.977536805Z -- add_column(:models, :excerpt, :text)
2025-09-17T15:46:56.977544791Z    -> 0.0024s
2025-09-17T15:46:56.977552687Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0038s) =================
2025-09-17T15:46:56.977560733Z 
2025-09-17T15:46:56.977568489Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-09-17T15:46:56.977576455Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-09-17T15:46:56.977586205Z -- add_column(:creators, :notes, :text)
2025-09-17T15:46:56.977597046Z    -> 0.0005s
2025-09-17T15:46:56.977607347Z -- add_column(:creators, :excerpt, :text)
2025-09-17T15:46:56.977617508Z    -> 0.0004s
2025-09-17T15:46:56.977627628Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-09-17T15:46:56.977638430Z 
2025-09-17T15:46:56.977648991Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-09-17T15:46:56.977673651Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-09-17T15:46:56.977685194Z -- add_column(:model_files, :notes, :text)
2025-09-17T15:46:56.977695244Z    -> 0.0007s
2025-09-17T15:46:56.977705605Z -- add_column(:model_files, :excerpt, :text)
2025-09-17T15:46:56.977716036Z    -> 0.0006s
2025-09-17T15:46:56.977726116Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0013s) =============
2025-09-17T15:46:56.977736668Z 
2025-09-17T15:46:56.977746688Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-09-17T15:46:56.977756898Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-09-17T15:46:56.977766918Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0254s) =================
2025-09-17T15:46:56.977777219Z 
2025-09-17T15:46:56.977786949Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-09-17T15:46:56.977796869Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-09-17T15:46:56.977807480Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-09-17T15:46:56.977817390Z    -> 0.0457s
2025-09-17T15:46:56.977827500Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0457s) =============
2025-09-17T15:46:56.977838212Z 
2025-09-17T15:46:56.977848022Z Migrating to RenameExcerptToCaption (20230222155910)
2025-09-17T15:46:56.977858623Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-09-17T15:46:56.977869295Z -- rename_column(:creators, :excerpt, :caption)
2025-09-17T15:46:56.977879455Z    -> 0.0235s
2025-09-17T15:46:56.977889575Z -- rename_column(:models, :excerpt, :caption)
2025-09-17T15:46:56.977898934Z    -> 0.0219s
2025-09-17T15:46:56.977908654Z -- rename_column(:model_files, :excerpt, :caption)
2025-09-17T15:46:56.977918534Z    -> 0.0202s
2025-09-17T15:46:56.977928273Z == 20230222155910 RenameExcerptToCaption: migrated (0.0682s) ==================
2025-09-17T15:46:56.977938243Z 
2025-09-17T15:46:56.977947933Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-09-17T15:46:56.977957743Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-09-17T15:46:56.977967041Z -- add_column(:libraries, :notes, :string)
2025-09-17T15:46:56.977976801Z    -> 0.0022s
2025-09-17T15:46:56.977986310Z -- add_column(:libraries, :caption, :string)
2025-09-17T15:46:57.535106026Z    -> 0.0007s
2025-09-17T15:46:57.535144844Z -- add_column(:libraries, :name, :string)
2025-09-17T15:46:57.535154844Z    -> 0.0005s
2025-09-17T15:46:57.535192129Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0129s) ============
2025-09-17T15:46:57.535201127Z 
2025-09-17T15:46:57.535209053Z Migrating to AddTagregexToLibrary (20230305180823)
2025-09-17T15:46:57.535217991Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-09-17T15:46:57.535226558Z -- add_column(:libraries, :tag_regex, :text)
2025-09-17T15:46:57.535234845Z    -> 0.0022s
2025-09-17T15:46:57.535243072Z == 20230305180823 AddTagregexToLibrary: migrated (0.0041s) ====================
2025-09-17T15:46:57.535251308Z 
2025-09-17T15:46:57.535259084Z Migrating to AddIconToLibrary (20230307215826)
2025-09-17T15:46:57.535267631Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-09-17T15:46:57.535276248Z -- add_column(:libraries, :icon, :text)
2025-09-17T15:46:57.535284405Z    -> 0.0020s
2025-09-17T15:46:57.535292311Z == 20230307215826 AddIconToLibrary: migrated (0.0038s) ========================
2025-09-17T15:46:57.535301108Z 
2025-09-17T15:46:57.535308974Z Migrating to CreateCollection (20230308004237)
2025-09-17T15:46:57.535317451Z == 20230308004237 CreateCollection: migrating =================================
2025-09-17T15:46:57.535325808Z -- create_table(:collections)
2025-09-17T15:46:57.535334015Z    -> 0.0031s
2025-09-17T15:46:57.535342341Z == 20230308004237 CreateCollection: migrated (0.0075s) ========================
2025-09-17T15:46:57.535351149Z 
2025-09-17T15:46:57.535359366Z Migrating to AddCollectionToModels (20230308005021)
2025-09-17T15:46:57.535367372Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-09-17T15:46:57.535375669Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-09-17T15:46:57.535384025Z    -> 0.0184s
2025-09-17T15:46:57.535391971Z == 20230308005021 AddCollectionToModels: migrated (0.0223s) ===================
2025-09-17T15:46:57.535400078Z 
2025-09-17T15:46:57.535407863Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-09-17T15:46:57.535415870Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-09-17T15:46:57.535424006Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0014s) =============
2025-09-17T15:46:57.535432232Z 
2025-09-17T15:46:57.535439978Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-09-17T15:46:57.535448605Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-09-17T15:46:57.535457243Z -- rename_column(:collections, :excerpt, :caption)
2025-09-17T15:46:57.535465219Z    -> 0.0043s
2025-09-17T15:46:57.535473075Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0043s) ========
2025-09-17T15:46:57.535492364Z 
2025-09-17T15:46:57.535500239Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-09-17T15:46:57.535508256Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-09-17T15:46:57.535516312Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-09-17T15:46:57.535524468Z 
2025-09-17T15:46:57.535532234Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-09-17T15:46:57.535541723Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-09-17T15:46:57.535550010Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-09-17T15:46:57.535559719Z    -> 0.0021s
2025-09-17T15:46:57.535567926Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0022s) ===============
2025-09-17T15:46:57.535575982Z 
2025-09-17T15:46:57.535583788Z Migrating to AddCollectionToCollections (20230324000000)
2025-09-17T15:46:57.535591854Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-09-17T15:46:57.535599900Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-09-17T15:46:57.535608377Z    -> 0.0062s
2025-09-17T15:46:57.535616734Z == 20230324000000 AddCollectionToCollections: migrated (0.0084s) ==============
2025-09-17T15:46:57.535624810Z 
2025-09-17T15:46:57.535632897Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-09-17T15:46:57.535641223Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-09-17T15:46:57.535649540Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0554s) =========
2025-09-17T15:46:57.535657666Z 
2025-09-17T15:46:57.535665362Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-09-17T15:46:57.535673358Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-09-17T15:46:57.535681464Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0078s) 
2025-09-17T15:46:57.535691715Z 
2025-09-17T15:46:57.535699491Z Migrating to AddSlugs (20230615135601)
2025-09-17T15:46:57.535707447Z == 20230615135601 AddSlugs: migrating =========================================
2025-09-17T15:46:57.535715683Z -- add_column(:models, :slug, :string)
2025-09-17T15:46:57.535724992Z    -> 0.0028s
2025-09-17T15:46:57.535733229Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-09-17T15:46:57.535742046Z    -> 0.0021s
2025-09-17T15:46:57.535750253Z -- add_column(:collections, :slug, :string)
2025-09-17T15:46:57.535758289Z    -> 0.0005s
2025-09-17T15:46:57.535775985Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-09-17T15:46:57.535784311Z    -> 0.0001s
2025-09-17T15:46:57.535792267Z -- add_column(:creators, :slug, :string)
2025-09-17T15:46:57.535800354Z    -> 0.0005s
2025-09-17T15:46:57.535808470Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-09-17T15:46:57.535817097Z    -> 0.0001s
2025-09-17T15:46:57.535825033Z == 20230615135601 AddSlugs: migrated (0.0066s) ================================
2025-09-17T15:46:57.535833841Z 
2025-09-17T15:46:57.535842499Z Migrating to GenerateSlugs (20230617222353)
2025-09-17T15:46:57.535866677Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-09-17T15:46:57.535874884Z == 20230617222353 GenerateSlugs: migrated (0.0566s) ===========================
2025-09-17T15:46:57.535883191Z 
2025-09-17T15:46:57.535891096Z Migrating to MakeNamesUnique (20230628194944)
2025-09-17T15:46:57.535899343Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-09-17T15:46:57.535908191Z == 20230628194944 MakeNamesUnique: migrated (0.0037s) =========================
2025-09-17T15:46:57.535916548Z 
2025-09-17T15:46:57.535924554Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-09-17T15:46:57.535932851Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-09-17T15:46:57.535941167Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-09-17T15:46:57.535950185Z    -> 0.0026s
2025-09-17T15:46:57.535958172Z -- remove_index(:creators, :slug)
2025-09-17T15:46:57.535966639Z    -> 0.0004s
2025-09-17T15:46:57.535974845Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-09-17T15:46:57.535983032Z    -> 0.0001s
2025-09-17T15:46:57.535991318Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-09-17T15:46:57.536000046Z    -> 0.0002s
2025-09-17T15:46:57.536007952Z -- remove_index(:collections, :slug)
2025-09-17T15:46:57.536016459Z    -> 0.0279s
2025-09-17T15:46:57.536024545Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-09-17T15:46:57.536032822Z    -> 0.0014s
2025-09-17T15:46:57.536040928Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0332s) ======
2025-09-17T15:46:57.536049405Z 
2025-09-17T15:46:57.536057431Z Migrating to AddSizeToModelFiles (20230707082403)
2025-09-17T15:46:57.536065618Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-09-17T15:46:57.536073874Z -- add_column(:model_files, :size, :integer)
2025-09-17T15:46:57.536092031Z    -> 0.0007s
2025-09-17T15:46:57.536100458Z == 20230707082403 AddSizeToModelFiles: migrated (0.0010s) =====================
2025-09-17T15:46:57.536108825Z 
2025-09-17T15:46:57.536116601Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-09-17T15:46:57.536124637Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-09-17T15:46:57.536132683Z -- change_column(:model_files, :size, :bigint)
2025-09-17T15:46:57.536140659Z    -> 0.0082s
2025-09-17T15:46:57.536148825Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0085s) ==================
2025-09-17T15:46:57.536157333Z 
2025-09-17T15:46:57.536165038Z Migrating to AddNoteToProblems (20230711111009)
2025-09-17T15:46:57.536173004Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-09-17T15:46:57.536182233Z -- add_column(:problems, :note, :string, {default: nil})
2025-09-17T15:46:57.536190249Z    -> 0.0012s
2025-09-17T15:46:57.536198175Z == 20230711111009 AddNoteToProblems: migrated (0.0022s) =======================
2025-09-17T15:46:57.536206261Z 
2025-09-17T15:46:57.536214167Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-09-17T15:46:57.536222303Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-09-17T15:46:57.536231632Z -- add_column(:users, :problem_settings, :json, {default: {"missing" => :danger, "empty" => :info, "nesting" => :warning, "inefficient" => :info, "duplicate" => :warning, "no_image" => :silent, "no_3d_model" => :silent, "non_manifold" => :warning, "inside_out" => :warning, "no_license" => :silent, "no_links" => :silent, "no_creator" => :silent, "no_tags" => :silent, "http_error" => :info, "file_naming" => :warning}})
2025-09-17T15:46:57.536245179Z    -> 0.0007s
2025-09-17T15:46:57.536253176Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0008s) ================
2025-09-17T15:46:57.536261272Z 
2025-09-17T15:46:57.536269058Z Migrating to AddLicenseToModel (20240127143358)
2025-09-17T15:46:57.536277014Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-09-17T15:46:57.536285080Z -- add_column(:models, :license, :string)
2025-09-17T15:46:57.536293096Z    -> 0.0006s
2025-09-17T15:46:57.536301182Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-09-17T15:46:57.536309449Z 
2025-09-17T15:46:57.536317174Z Migrating to AddIgnoredToProblems (20240131134832)
2025-09-17T15:46:57.536325150Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-09-17T15:46:57.536333227Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-09-17T15:46:57.536341674Z    -> 0.0006s
2025-09-17T15:46:57.536359109Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-09-17T15:46:57.536367456Z 
2025-09-17T15:46:57.536375502Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-09-17T15:46:57.536383608Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-09-17T15:46:57.536391654Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-09-17T15:46:57.536400172Z    -> 0.0108s
2025-09-17T15:46:57.536408268Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0109s) ======
2025-09-17T15:46:57.536416514Z 
2025-09-17T15:46:57.536424410Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-09-17T15:46:57.536433298Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-09-17T15:46:57.536441585Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-09-17T15:46:57.536450503Z    -> 0.0007s
2025-09-17T15:46:57.536458439Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0008s) ===============
2025-09-17T15:46:57.536466565Z 
2025-09-17T15:46:57.536474481Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-09-17T15:46:57.536482477Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-09-17T15:46:57.536490544Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-09-17T15:46:57.536499041Z    -> 0.0002s
2025-09-17T15:46:57.536506937Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-09-17T15:46:57.536515263Z    -> 0.0010s
2025-09-17T15:46:57.536523179Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-09-17T15:46:57.536531496Z    -> 0.0002s
2025-09-17T15:46:57.536539462Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-09-17T15:46:57.536548009Z    -> 0.0046s
2025-09-17T15:46:58.013060620Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0062s) =================
2025-09-17T15:46:58.013092494Z 
2025-09-17T15:46:58.013097725Z Migrating to CreateFlipperTables (20240306095646)
2025-09-17T15:46:58.013101562Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-09-17T15:46:58.013105280Z -- create_table(:flipper_features)
2025-09-17T15:46:58.013108937Z    -> 0.0028s
2025-09-17T15:46:58.013112825Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-09-17T15:46:58.013116653Z    -> 0.0050s
2025-09-17T15:46:58.013120591Z -- create_table(:flipper_gates)
2025-09-17T15:46:58.013174209Z    -> 0.0003s
2025-09-17T15:46:58.013183207Z -- add_index(:flipper_gates, [:feature_key, :key, :value], {unique: true, length: {value: 255}, name: "index_flipper_gates_on_feature_key_and_key_and_value"})
2025-09-17T15:46:58.013191944Z    -> 0.0002s
2025-09-17T15:46:58.013200191Z == 20240306095646 CreateFlipperTables: migrated (0.0083s) =====================
2025-09-17T15:46:58.013208398Z 
2025-09-17T15:46:58.013216384Z Migrating to RolifyCreateRoles (20240319155251)
2025-09-17T15:46:58.013224470Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-09-17T15:46:58.013232917Z -- create_table(:roles)
2025-09-17T15:46:58.013241214Z    -> 0.0412s
2025-09-17T15:46:58.013249420Z -- create_table(:users_roles, {id: false})
2025-09-17T15:46:58.013257466Z    -> 0.0005s
2025-09-17T15:46:58.013266404Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-09-17T15:46:58.013274811Z    -> 0.0052s
2025-09-17T15:46:58.013283038Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-09-17T15:46:58.013291866Z    -> 0.0010s
2025-09-17T15:46:58.013300333Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-09-17T15:46:58.013308690Z    -> 0.0001s
2025-09-17T15:46:58.013316776Z == 20240319155251 RolifyCreateRoles: migrated (0.0665s) =======================
2025-09-17T15:46:58.013324922Z 
2025-09-17T15:46:58.013333349Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-09-17T15:46:58.013341456Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-09-17T15:46:58.013349602Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0095s) ==================
2025-09-17T15:46:58.013358069Z 
2025-09-17T15:46:58.013366135Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-09-17T15:46:58.013374342Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-09-17T15:46:58.013382598Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-17T15:46:58.013391115Z    -> 0.0253s
2025-09-17T15:46:58.013399232Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0269s) ====================
2025-09-17T15:46:58.013407749Z 
2025-09-17T15:46:58.013415976Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-09-17T15:46:58.013424232Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-09-17T15:46:58.013433361Z -- add_column(:users, :reset_password_token, :string)
2025-09-17T15:46:58.013441908Z    -> 0.0012s
2025-09-17T15:46:58.013450235Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-09-17T15:46:58.013470756Z    -> 0.0002s
2025-09-17T15:46:58.013478952Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0033s) ============
2025-09-17T15:46:58.013487449Z 
2025-09-17T15:46:58.013495265Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-09-17T15:46:58.013503532Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-09-17T15:46:58.013511979Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0261s) ==============
2025-09-17T15:46:58.013520436Z 
2025-09-17T15:46:58.013528662Z Migrating to AddRememberableToUsers (20240410221112)
2025-09-17T15:46:58.013536719Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-09-17T15:46:58.013545065Z -- add_column(:users, :remember_created_at, :datetime)
2025-09-17T15:46:58.013553212Z    -> 0.0033s
2025-09-17T15:46:58.013561408Z == 20240410221112 AddRememberableToUsers: migrated (0.0046s) ==================
2025-09-17T15:46:58.013569795Z 
2025-09-17T15:46:58.013577872Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-09-17T15:46:58.013588032Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-09-17T15:46:58.013596188Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-09-17T15:46:58.013604305Z    -> 0.0007s
2025-09-17T15:46:58.013612281Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0019s) ===========
2025-09-17T15:46:58.013620417Z 
2025-09-17T15:46:58.013628203Z Migrating to DropDelayedJobs (20240418112821)
2025-09-17T15:46:58.013636229Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-09-17T15:46:58.013644806Z -- drop_table(:delayed_jobs)
2025-09-17T15:46:58.013652772Z    -> 0.0019s
2025-09-17T15:46:58.013660708Z == 20240418112821 DropDelayedJobs: migrated (0.0123s) =========================
2025-09-17T15:46:58.013669256Z 
2025-09-17T15:46:58.013677342Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-09-17T15:46:58.013685619Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-09-17T15:46:58.013693745Z -- add_column(:users, :interface_language, :string)
2025-09-17T15:46:58.013701801Z    -> 0.0007s
2025-09-17T15:46:58.013709837Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0042s) =============
2025-09-17T15:46:58.013717964Z 
2025-09-17T15:46:58.013725799Z Migrating to AddLockableToUsers (20240610120318)
2025-09-17T15:46:58.013734026Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-09-17T15:46:58.013742212Z -- change_table(:users)
2025-09-17T15:46:58.013760119Z    -> 0.0018s
2025-09-17T15:46:58.013768165Z == 20240610120318 AddLockableToUsers: migrated (0.0021s) ======================
2025-09-17T15:46:58.013776481Z 
2025-09-17T15:46:58.013784397Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-09-17T15:46:58.013792734Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-09-17T15:46:58.013801031Z -- add_column(:model_files, :attachment_data, :json)
2025-09-17T15:46:58.013809268Z    -> 0.0009s
2025-09-17T15:46:58.013817264Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0013s) ===========
2025-09-17T15:46:58.013825731Z 
2025-09-17T15:46:58.013833677Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-09-17T15:46:58.013842595Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-09-17T15:46:58.013851122Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0150s) ==================
2025-09-17T15:46:58.013859268Z 
2025-09-17T15:46:58.013867104Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-09-17T15:46:58.013875170Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-09-17T15:46:58.013883277Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-09-17T15:46:58.013891633Z    -> 0.0008s
2025-09-17T15:46:58.013899599Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0028s) ============
2025-09-17T15:46:58.013907696Z 
2025-09-17T15:46:58.013915852Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-09-17T15:46:58.013924309Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-09-17T15:46:58.013932446Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-09-17T15:46:58.013940913Z    -> 0.0008s
2025-09-17T15:46:58.013949380Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-09-17T15:46:58.013959380Z    -> 0.0006s
2025-09-17T15:46:58.013967536Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-09-17T15:46:58.013976134Z    -> 0.0007s
2025-09-17T15:46:58.013984370Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-09-17T15:46:58.013992486Z    -> 0.0056s
2025-09-17T15:46:58.014000422Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-09-17T15:46:58.014008549Z    -> 0.0008s
2025-09-17T15:46:58.014016525Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0100s) ====================
2025-09-17T15:46:58.014024651Z 
2025-09-17T15:46:58.014032437Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-09-17T15:46:58.014040443Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-09-17T15:46:58.014058209Z -- remove_index(:libraries, :path)
2025-09-17T15:46:58.014066255Z    -> 0.0012s
2025-09-17T15:46:58.014074231Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0020s) ================
2025-09-17T15:46:58.014082337Z 
2025-09-17T15:46:58.014090133Z Migrating to CreateFederailsActors (20240727113215)
2025-09-17T15:46:58.014098279Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-09-17T15:46:58.014106807Z -- create_table(:federails_actors)
2025-09-17T15:46:58.014115033Z    -> 0.0009s
2025-09-17T15:46:58.014123681Z -- foreign_key_exists?(:federails_actors, :users)
2025-09-17T15:46:58.014131837Z    -> 0.0020s
2025-09-17T15:46:58.014140054Z -- remove_foreign_key(:federails_actors, :users)
2025-09-17T15:46:58.014148070Z    -> 0.0149s
2025-09-17T15:46:58.014156407Z -- remove_index(:federails_actors, :user_id)
2025-09-17T15:46:58.014164753Z    -> 0.0004s
2025-09-17T15:46:58.014172950Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-09-17T15:46:58.014181457Z    -> 0.0001s
2025-09-17T15:46:58.014190305Z -- add_foreign_key(:federails_actors, :users)
2025-09-17T15:46:58.014198782Z    -> 0.0106s
2025-09-17T15:46:58.014207560Z == 20240727113215 CreateFederailsActors: migrated (0.0299s) ===================
2025-09-17T15:46:58.014216127Z 
2025-09-17T15:46:58.014223973Z Migrating to CreateFederailsFollowings (20240727113216)
2025-09-17T15:46:58.014232660Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-09-17T15:46:58.014240977Z -- create_table(:federails_followings)
2025-09-17T15:46:58.014249233Z    -> 0.0012s
2025-09-17T15:46:58.014257550Z == 20240727113216 CreateFederailsFollowings: migrated (0.0012s) ===============
2025-09-17T15:46:58.014265817Z 
2025-09-17T15:46:58.014274013Z Migrating to CreateFederailsActivities (20240727113217)
2025-09-17T15:46:58.014282320Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-09-17T15:46:58.014290517Z -- create_table(:federails_activities)
2025-09-17T15:46:58.014298753Z    -> 0.0088s
2025-09-17T15:46:58.014306729Z == 20240727113217 CreateFederailsActivities: migrated (0.0088s) ===============
2025-09-17T15:46:58.014314805Z 
2025-09-17T15:46:58.014323002Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-09-17T15:46:58.014331219Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-09-17T15:46:58.014339555Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-09-17T15:46:58.014358203Z    -> 0.0081s
2025-09-17T15:46:58.014366329Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-09-17T15:46:58.014374546Z    -> 0.0004s
2025-09-17T15:46:58.014382652Z -- change_table(:federails_actors)
2025-09-17T15:46:58.014390778Z    -> 0.0064s
2025-09-17T15:46:58.014398795Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0150s) =======
2025-09-17T15:46:58.014406951Z 
2025-09-17T15:46:58.014414917Z Migrating to CreateFederailsActors (20240731165647)
2025-09-17T15:46:58.014423053Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-09-17T15:46:58.014431180Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-09-17T15:46:58.014439727Z 
2025-09-17T15:46:58.014447713Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-09-17T15:46:58.014455960Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-09-17T15:46:58.014464357Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-09-17T15:46:58.014472463Z 
2025-09-17T15:46:58.014480269Z Migrating to BackfillActivities (20240805111500)
2025-09-17T15:46:58.014488265Z == 20240805111500 BackfillActivities: migrating ===============================
2025-09-17T15:46:58.014496361Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-09-17T15:46:58.014504538Z 
2025-09-17T15:46:58.014514047Z Migrating to CreateCaberRelations (20240827155630)
2025-09-17T15:46:58.014522414Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-09-17T15:46:58.014530891Z -- create_table(:caber_relations)
2025-09-17T15:46:58.014538897Z    -> 0.0397s
2025-09-17T15:46:58.014546883Z == 20240827155630 CreateCaberRelations: migrated (0.0398s) ====================
2025-09-17T15:46:58.014555059Z 
2025-09-17T15:46:58.014562905Z Migrating to AddDefaultAccessControls (20240830121749)
2025-09-17T15:46:58.014570921Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-09-17T15:46:58.014578987Z == 20240830121749 AddDefaultAccessControls: migrated (0.0233s) ================
2025-09-17T15:46:58.014587094Z 
2025-09-17T15:46:58.014595831Z Migrating to RenameDefaultRoles (20240830151650)
2025-09-17T15:46:58.745009490Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-09-17T15:46:58.745031845Z == 20240830151650 RenameDefaultRoles: migrated (0.0429s) ======================
2025-09-17T15:46:58.745036034Z 
2025-09-17T15:46:58.745039872Z Migrating to AddPublicIDsToModels (20240904151944)
2025-09-17T15:46:58.745043539Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-09-17T15:46:58.745063649Z -- add_column(:models, :public_id, :string)
2025-09-17T15:46:58.745067617Z    -> 0.0008s
2025-09-17T15:46:58.745071495Z -- add_index(:models, :public_id)
2025-09-17T15:46:58.745075193Z    -> 0.0028s
2025-09-17T15:46:58.745078840Z -- add_column(:model_files, :public_id, :string)
2025-09-17T15:46:58.745082477Z    -> 0.0007s
2025-09-17T15:46:58.745086145Z -- add_index(:model_files, :public_id)
2025-09-17T15:46:58.745089732Z    -> 0.0001s
2025-09-17T15:46:58.745093379Z -- add_column(:problems, :public_id, :string)
2025-09-17T15:46:58.745097107Z    -> 0.0007s
2025-09-17T15:46:58.745101155Z -- add_index(:problems, :public_id)
2025-09-17T15:46:58.745105253Z    -> 0.0002s
2025-09-17T15:46:58.745108850Z -- add_column(:creators, :public_id, :string)
2025-09-17T15:46:58.745112508Z    -> 0.0007s
2025-09-17T15:46:58.745116185Z -- add_index(:creators, :public_id)
2025-09-17T15:46:58.745119792Z    -> 0.0002s
2025-09-17T15:46:58.745123871Z -- add_column(:collections, :public_id, :string)
2025-09-17T15:46:58.745127498Z    -> 0.0008s
2025-09-17T15:46:58.745131075Z -- add_index(:collections, :public_id)
2025-09-17T15:46:58.745134632Z    -> 0.0001s
2025-09-17T15:46:58.745138159Z -- add_column(:libraries, :public_id, :string)
2025-09-17T15:46:58.745141717Z    -> 0.0007s
2025-09-17T15:46:58.745145244Z -- add_index(:libraries, :public_id)
2025-09-17T15:46:58.745148791Z    -> 0.0001s
2025-09-17T15:46:58.745152779Z == 20240904151944 AddPublicIDsToModels: migrated (0.0081s) ====================
2025-09-17T15:46:58.745156817Z 
2025-09-17T15:46:58.745160334Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-09-17T15:46:58.745163931Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-09-17T15:46:58.745167589Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:46:58.745171346Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0378s) ==============
2025-09-17T15:46:58.745175254Z 
2025-09-17T15:46:58.745178751Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-09-17T15:46:58.745182409Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-09-17T15:46:58.745186296Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-09-17T15:46:58.745189894Z 
2025-09-17T15:46:58.745193361Z Migrating to DeduplicateRoles (20240923114515)
2025-09-17T15:46:58.745197278Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-09-17T15:46:58.745200916Z == 20240923114515 DeduplicateRoles: migrated (0.1522s) ========================
2025-09-17T15:46:58.745208962Z 
2025-09-17T15:46:58.745212539Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-09-17T15:46:58.745216497Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-09-17T15:46:58.745220335Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-17T15:46:58.745224213Z    -> 0.1714s
2025-09-17T15:46:58.745230044Z -- add_index(:models, :name_lower)
2025-09-17T15:46:58.745234253Z    -> 0.0002s
2025-09-17T15:46:58.745237830Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-17T15:46:58.745241868Z    -> 0.0067s
2025-09-17T15:46:58.745246077Z -- add_index(:creators, :name_lower)
2025-09-17T15:46:58.745249714Z    -> 0.0001s
2025-09-17T15:46:58.745253682Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-17T15:46:58.745257951Z    -> 0.0269s
2025-09-17T15:46:58.745261628Z -- add_index(:collections, :name_lower)
2025-09-17T15:46:58.745265265Z    -> 0.0002s
2025-09-17T15:46:58.745268893Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.2056s) =============
2025-09-17T15:46:58.745272590Z 
2025-09-17T15:46:58.745277310Z Migrating to AddKeypairToActors (20240926162407)
2025-09-17T15:46:58.745280977Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-09-17T15:46:58.745284945Z -- change_table(:federails_actors)
2025-09-17T15:46:58.745288783Z    -> 0.0021s
2025-09-17T15:46:58.745292620Z == 20240926162407 AddKeypairToActors: migrated (0.0021s) ======================
2025-09-17T15:46:58.745296749Z 
2025-09-17T15:46:58.745300717Z Migrating to AddUuids (20241004194445)
2025-09-17T15:46:58.745304264Z == 20241004194445 AddUuids: migrating =========================================
2025-09-17T15:46:58.745307991Z -- change_table(:federails_actors)
2025-09-17T15:46:58.745311969Z    -> 0.0044s
2025-09-17T15:46:58.745315757Z -- change_table(:federails_activities)
2025-09-17T15:46:58.745319284Z    -> 0.0012s
2025-09-17T15:46:58.745323102Z -- change_table(:federails_followings)
2025-09-17T15:46:58.745326639Z    -> 0.0012s
2025-09-17T15:46:58.745330567Z == 20241004194445 AddUuids: migrated (0.0069s) ================================
2025-09-17T15:46:58.745334234Z 
2025-09-17T15:46:58.745337862Z Migrating to CreateComments (20241007182824)
2025-09-17T15:46:58.745341699Z == 20241007182824 CreateComments: migrating ===================================
2025-09-17T15:46:58.745349896Z -- create_table(:comments)
2025-09-17T15:46:58.745353433Z    -> 0.0029s
2025-09-17T15:46:58.745357601Z == 20241007182824 CreateComments: migrated (0.0029s) ==========================
2025-09-17T15:46:58.745361409Z 
2025-09-17T15:46:58.745364866Z Migrating to AddSystemToComments (20241009122540)
2025-09-17T15:46:58.745368473Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-09-17T15:46:58.745372101Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-09-17T15:46:58.745375738Z    -> 0.0014s
2025-09-17T15:46:58.745379566Z == 20241009122540 AddSystemToComments: migrated (0.0014s) =====================
2025-09-17T15:46:58.745383163Z 
2025-09-17T15:46:58.745386690Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-09-17T15:46:58.745390357Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-09-17T15:46:58.745393965Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0036s) ============
2025-09-17T15:46:58.745397892Z 
2025-09-17T15:46:58.745401359Z Migrating to AddOmniauthToUsers (20241015090803)
2025-09-17T15:46:58.745404927Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-09-17T15:46:58.745408875Z -- add_column(:users, :auth_provider, :string)
2025-09-17T15:46:58.745412492Z    -> 0.0013s
2025-09-17T15:46:58.745416039Z -- add_column(:users, :auth_uid, :string)
2025-09-17T15:46:58.745420017Z    -> 0.0010s
2025-09-17T15:46:58.745424406Z == 20241015090803 AddOmniauthToUsers: migrated (0.0024s) ======================
2025-09-17T15:46:58.745428183Z 
2025-09-17T15:46:58.745431751Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-09-17T15:46:58.745435438Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-09-17T15:46:58.745439075Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-09-17T15:46:58.745442793Z    -> 0.0013s
2025-09-17T15:46:58.745446480Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-09-17T15:46:58.745450208Z    -> 0.0011s
2025-09-17T15:46:58.745453835Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0035s) =====
2025-09-17T15:46:58.745457533Z 
2025-09-17T15:46:58.745461080Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-09-17T15:46:58.745464687Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-09-17T15:46:58.745468314Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-09-17T15:46:58.745472292Z    -> 0.0014s
2025-09-17T15:46:58.745475829Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0014s) ======
2025-09-17T15:46:58.745487513Z 
2025-09-17T15:46:58.745491110Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-09-17T15:46:58.745494768Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-09-17T15:46:58.745498385Z -- change_table(:users)
2025-09-17T15:46:58.745502203Z    -> 0.0016s
2025-09-17T15:46:58.745505950Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0016s) =====================
2025-09-17T15:46:58.745509617Z 
2025-09-17T15:46:58.745513225Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-09-17T15:46:58.745517213Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-09-17T15:46:58.745521081Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0084s) =================
2025-09-17T15:46:58.745524768Z 
2025-09-17T15:46:58.745528315Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-09-17T15:46:58.745531882Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-09-17T15:46:58.745535520Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-09-17T15:46:58.745539367Z    -> 0.0014s
2025-09-17T15:46:58.745542935Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-09-17T15:46:58.745546682Z    -> 0.0024s
2025-09-17T15:46:58.745550229Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-09-17T15:46:58.745554899Z    -> 0.0007s
2025-09-17T15:46:58.745558416Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-09-17T15:46:58.745562113Z    -> 0.0009s
2025-09-17T15:46:58.745565941Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-09-17T15:46:58.745569638Z    -> 0.0010s
2025-09-17T15:46:58.745573175Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-09-17T15:46:58.745576873Z    -> 0.0009s
2025-09-17T15:46:58.745580691Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-09-17T15:46:58.745584458Z    -> 0.0005s
2025-09-17T15:46:58.745588005Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0079s) ===================
2025-09-17T15:46:58.745591643Z 
2025-09-17T15:46:58.745595150Z Migrating to AddInProgressToProblems (20241105121830)
2025-09-17T15:46:58.745598737Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-09-17T15:46:58.745602354Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-09-17T15:46:58.745605972Z    -> 0.0009s
2025-09-17T15:46:58.745609489Z == 20241105121830 AddInProgressToProblems: migrated (0.0009s) =================
2025-09-17T15:46:58.745617395Z 
2025-09-17T15:46:58.745620892Z Migrating to ClearStuckProblems (20241118155027)
2025-09-17T15:46:58.745624469Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-09-17T15:46:58.745628417Z == 20241118155027 ClearStuckProblems: migrated (0.0291s) ======================
2025-09-17T15:46:58.745632044Z 
2025-09-17T15:46:58.745635511Z Migrating to AddApprovedToUser (20241122121621)
2025-09-17T15:46:58.745639138Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-09-17T15:46:58.745643507Z -- change_table(:users)
2025-09-17T15:46:58.745647936Z    -> 0.0016s
2025-09-17T15:46:58.745652295Z == 20241122121621 AddApprovedToUser: migrated (0.0017s) =======================
2025-09-17T15:46:58.745655922Z 
2025-09-17T15:46:58.745659670Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-09-17T15:46:58.745664149Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-09-17T15:46:58.745668658Z -- create_table(:federails_moderation_reports)
2025-09-17T15:46:58.745672646Z    -> 0.0034s
2025-09-17T15:46:58.745676163Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0035s) ========
2025-09-17T15:46:58.745679770Z 
2025-09-17T15:46:58.745683237Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-09-17T15:46:58.745686824Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-09-17T15:46:58.745690532Z -- create_table(:federails_moderation_domain_blocks)
2025-09-17T15:46:58.745694109Z    -> 0.0005s
2025-09-17T15:46:58.745697636Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0006s) ===
2025-09-17T15:46:58.745701243Z 
2025-09-17T15:46:58.745704710Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-09-17T15:46:58.745708318Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-09-17T15:46:58.745711915Z -- change_column_null(:comments, :commenter_id, true)
2025-09-17T15:46:58.745715713Z    -> 0.0080s
2025-09-17T15:46:58.745719270Z -- change_column_null(:comments, :commenter_type, true)
2025-09-17T15:46:58.745722847Z    -> 0.0093s
2025-09-17T15:46:58.745726374Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-09-17T15:46:58.745729971Z    -> 0.0008s
2025-09-17T15:46:58.745733488Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-09-17T15:46:58.745737096Z    -> 0.0108s
2025-09-17T15:46:59.683972856Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0305s) =======
2025-09-17T15:46:59.684036434Z 
2025-09-17T15:46:59.684045973Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-09-17T15:46:59.684054621Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-09-17T15:46:59.684063579Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-09-17T15:46:59.684071835Z    -> 0.0012s
2025-09-17T15:46:59.684080172Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0012s) =================
2025-09-17T15:46:59.684088930Z 
2025-09-17T15:46:59.684096826Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-09-17T15:46:59.684105293Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-09-17T15:46:59.684113389Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1744s) ==================
2025-09-17T15:46:59.684121465Z 
2025-09-17T15:46:59.684129321Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-09-17T15:46:59.684137367Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-09-17T15:46:59.684145353Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-09-17T15:46:59.684153430Z    -> 0.0019s
2025-09-17T15:46:59.684161376Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0019s) ==========
2025-09-17T15:46:59.684169512Z 
2025-09-17T15:46:59.684177168Z Migrating to AddCreatorToCollections (20250222000000)
2025-09-17T15:46:59.684185394Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-09-17T15:46:59.684193440Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-09-17T15:46:59.684201747Z    -> 0.0240s
2025-09-17T15:46:59.684209903Z == 20250222000000 AddCreatorToCollections: migrated (0.0241s) =================
2025-09-17T15:46:59.684218531Z 
2025-09-17T15:46:59.684226737Z Migrating to AddLocalToActors (20250305171530)
2025-09-17T15:46:59.684235004Z == 20250305171530 AddLocalToActors: migrating =================================
2025-09-17T15:46:59.684243020Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-09-17T15:46:59.684251267Z    -> 0.0010s
2025-09-17T15:46:59.684259293Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-09-17T15:46:59.684268281Z    -> 0.0020s
2025-09-17T15:46:59.684276538Z    -> 0 rows
2025-09-17T15:46:59.684284424Z == 20250305171530 AddLocalToActors: migrated (0.0062s) ========================
2025-09-17T15:46:59.684292750Z 
2025-09-17T15:46:59.684300596Z Migrating to AddActorTypeToActors (20250407160721)
2025-09-17T15:46:59.684308542Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-09-17T15:46:59.684325947Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-09-17T15:46:59.684334063Z    -> 0.0010s
2025-09-17T15:46:59.684342310Z == 20250407160721 AddActorTypeToActors: migrated (0.0010s) ====================
2025-09-17T15:46:59.684350386Z 
2025-09-17T15:46:59.684358122Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-09-17T15:46:59.684366098Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-09-17T15:46:59.684376248Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-09-17T15:46:59.684384675Z    -> 0.0032s
2025-09-17T15:46:59.684392511Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0032s) =================
2025-09-17T15:46:59.684400507Z 
2025-09-17T15:46:59.684408223Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-09-17T15:46:59.684416119Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-09-17T15:46:59.684426790Z -- create_table(:oauth_applications)
2025-09-17T15:46:59.684436660Z    -> 0.0006s
2025-09-17T15:46:59.684447021Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-09-17T15:46:59.684457181Z    -> 0.0002s
2025-09-17T15:46:59.684467703Z -- create_table(:oauth_access_grants)
2025-09-17T15:46:59.684477452Z    -> 0.0007s
2025-09-17T15:46:59.684487783Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-09-17T15:46:59.684498014Z    -> 0.0001s
2025-09-17T15:46:59.684507944Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-09-17T15:46:59.684518405Z    -> 0.0168s
2025-09-17T15:46:59.684528615Z -- create_table(:oauth_access_tokens)
2025-09-17T15:46:59.684538896Z    -> 0.0007s
2025-09-17T15:46:59.684548746Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-09-17T15:46:59.684558976Z    -> 0.0001s
2025-09-17T15:46:59.684569628Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-09-17T15:46:59.684579638Z    -> 0.0001s
2025-09-17T15:46:59.684589929Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-09-17T15:46:59.684600089Z    -> 0.0114s
2025-09-17T15:46:59.684610680Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-09-17T15:46:59.684621262Z    -> 0.0097s
2025-09-17T15:46:59.684631142Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-09-17T15:46:59.684641242Z    -> 0.0182s
2025-09-17T15:46:59.684650340Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0591s) ==================
2025-09-17T15:46:59.684659028Z 
2025-09-17T15:46:59.684680030Z Migrating to AddOwnerToApplication (20250408145956)
2025-09-17T15:46:59.684688307Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-09-17T15:46:59.684696804Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-09-17T15:46:59.684705030Z    -> 0.0010s
2025-09-17T15:46:59.684713147Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-09-17T15:46:59.684721383Z    -> 0.0008s
2025-09-17T15:46:59.684729420Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-09-17T15:46:59.684737736Z    -> 0.0007s
2025-09-17T15:46:59.684745943Z == 20250408145956 AddOwnerToApplication: migrated (0.0078s) ===================
2025-09-17T15:46:59.684754280Z 
2025-09-17T15:46:59.684764901Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-09-17T15:46:59.684773468Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-09-17T15:46:59.684781494Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-09-17T15:46:59.684789521Z    -> 0.0142s
2025-09-17T15:46:59.684797587Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0157s) ============
2025-09-17T15:46:59.684805623Z 
2025-09-17T15:46:59.684813308Z Migrating to AddQuotaToUsers (20250409125753)
2025-09-17T15:46:59.684821986Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-09-17T15:46:59.684830553Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-09-17T15:46:59.684838549Z    -> 0.0010s
2025-09-17T15:46:59.684846385Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-09-17T15:46:59.684854491Z    -> 0.0009s
2025-09-17T15:46:59.684862367Z == 20250409125753 AddQuotaToUsers: migrated (0.0036s) =========================
2025-09-17T15:46:59.684870945Z 
2025-09-17T15:46:59.684878961Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-09-17T15:46:59.684886947Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-09-17T15:46:59.684895223Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-09-17T15:46:59.684903781Z    -> 0.0129s
2025-09-17T15:46:59.684911687Z -- add_index(:model_files, :filename_lower)
2025-09-17T15:46:59.684919693Z    -> 0.0002s
2025-09-17T15:46:59.684927528Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0146s) 
2025-09-17T15:46:59.684935575Z 
2025-09-17T15:46:59.684943280Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-09-17T15:46:59.684951316Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-09-17T15:46:59.684981407Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-09-17T15:46:59.684989603Z    -> 0.0002s
2025-09-17T15:46:59.684997710Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0012s) ===================
2025-09-17T15:46:59.685005806Z 
2025-09-17T15:46:59.685013572Z Migrating to AddPreviewToModelFile (20250520111046)
2025-09-17T15:46:59.685021568Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-09-17T15:46:59.685029594Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-09-17T15:46:59.685038041Z    -> 0.0010s
2025-09-17T15:46:59.685045937Z == 20250520111046 AddPreviewToModelFile: migrated (0.0019s) ===================
2025-09-17T15:46:59.685054214Z 
2025-09-17T15:46:59.685061939Z Migrating to CreateAltchaSolutions (20250609210440)
2025-09-17T15:46:59.685071739Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-09-17T15:46:59.685082020Z -- create_table(:altcha_solutions)
2025-09-17T15:46:59.685092431Z    -> 0.0004s
2025-09-17T15:46:59.685103052Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-09-17T15:46:59.685114144Z    -> 0.0002s
2025-09-17T15:46:59.685124475Z == 20250609210440 CreateAltchaSolutions: migrated (0.0017s) ===================
2025-09-17T15:46:59.685135036Z 
2025-09-17T15:46:59.685144866Z Migrating to AddIndexableFields (20250620141805)
2025-09-17T15:46:59.685155608Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-09-17T15:46:59.685165678Z -- change_table(:models)
2025-09-17T15:46:59.685175849Z    -> 0.0025s
2025-09-17T15:46:59.685185809Z -- change_table(:creators)
2025-09-17T15:46:59.685196069Z    -> 0.0017s
2025-09-17T15:46:59.685206921Z -- change_table(:collections)
2025-09-17T15:46:59.685217122Z    -> 0.0016s
2025-09-17T15:46:59.685227062Z == 20250620141805 AddIndexableFields: migrated (0.0058s) ======================
2025-09-17T15:46:59.685238374Z 
2025-09-17T15:46:59.685250098Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-09-17T15:46:59.685260770Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-09-17T15:46:59.685271030Z -- change_column(:models, :indexable, :string)
2025-09-17T15:46:59.685279477Z    -> 0.0256s
2025-09-17T15:46:59.685288034Z -- change_column(:models, :ai_indexable, :string)
2025-09-17T15:46:59.685296271Z    -> 0.0172s
2025-09-17T15:46:59.685304959Z -- change_column(:creators, :indexable, :string)
2025-09-17T15:46:59.685325720Z    -> 0.0088s
2025-09-17T15:46:59.685334348Z -- change_column(:creators, :ai_indexable, :string)
2025-09-17T15:46:59.685342364Z    -> 0.0092s
2025-09-17T15:46:59.685350320Z -- change_column(:collections, :indexable, :string)
2025-09-17T15:46:59.685359929Z    -> 0.0619s
2025-09-17T15:46:59.685368136Z -- change_column(:collections, :ai_indexable, :string)
2025-09-17T15:46:59.685376442Z    -> 0.0126s
2025-09-17T15:46:59.685384439Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1357s) ======
2025-09-17T15:46:59.685393607Z 
2025-09-17T15:46:59.685401413Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-09-17T15:46:59.685409940Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-09-17T15:46:59.685418607Z -- change_table(:models)
2025-09-17T15:46:59.685426453Z    -> 0.0004s
2025-09-17T15:46:59.685434359Z -- change_table(:creators)
2025-09-17T15:46:59.685442866Z    -> 0.0003s
2025-09-17T15:46:59.685450712Z -- change_table(:collections)
2025-09-17T15:46:59.685458528Z    -> 0.0003s
2025-09-17T15:46:59.685466404Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0009s) =================
2025-09-17T15:46:59.685474450Z 
2025-09-17T15:46:59.685482215Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-09-17T15:46:59.685490191Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-09-17T15:46:59.685498278Z -- change_table(:links)
2025-09-17T15:46:59.685506194Z    -> 0.0002s
2025-09-17T15:46:59.685514110Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-09-17T15:46:59.685522156Z 
2025-09-17T15:46:59.685529861Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-09-17T15:46:59.685537847Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-09-17T15:46:59.685545884Z -- add_column(:links, :synced_at, :datetime)
2025-09-17T15:46:59.685553810Z    -> 0.0010s
2025-09-17T15:46:59.685561746Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0010s) ======================
2025-09-17T15:46:59.685569782Z 
2025-09-17T15:46:59.685577517Z Migrating to CreateFaspClientProviders (20250806142734)
2025-09-17T15:46:59.685585503Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-09-17T15:46:59.685593530Z -- create_table(:fasp_client_providers)
2025-09-17T15:46:59.685601446Z    -> 0.0486s
2025-09-17T15:46:59.685609321Z == 20250806142734 CreateFaspClientProviders: migrated (0.0486s) ===============
2025-09-17T15:46:59.685617378Z 
2025-09-17T15:46:59.685625574Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-09-17T15:46:59.685643821Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-09-17T15:46:59.685651937Z -- create_table(:fasp_client_event_subscriptions)
2025-09-17T15:46:59.685659923Z    -> 0.0175s
2025-09-17T15:46:59.685668050Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0176s) ======
2025-09-17T15:46:59.685676106Z 
2025-09-17T15:46:59.685684653Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-09-17T15:46:59.709379947Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-09-17T15:46:59.709427533Z -- create_table(:fasp_client_backfill_requests)
2025-09-17T15:46:59.709436932Z    -> 0.0057s
2025-09-17T15:46:59.709446050Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0058s) ========
2025-09-17T15:46:59.709454657Z 
2025-09-17T15:46:59.778430821Z s6-rc: info: service init-manyfold-config successfully started
2025-09-17T15:46:59.778764393Z s6-rc: info: service init-config-end: starting
2025-09-17T15:46:59.781187933Z s6-rc: info: service init-config-end successfully started
2025-09-17T15:46:59.781563960Z s6-rc: info: service init-mods: starting
2025-09-17T15:46:59.783380548Z s6-rc: info: service init-mods successfully started
2025-09-17T15:46:59.783544168Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-09-17T15:46:59.792125458Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-09-17T15:46:59.792356533Z s6-rc: info: service init-mods-package-install: starting
2025-09-17T15:46:59.804723797Z [pkg-install-init] **** Installing all mod packages ****
2025-09-17T15:46:59.815464745Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-09-17T15:46:59.894040660Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-09-17T15:47:00.234006332Z (1/1) Installing redis (8.0.3-r0)
2025-09-17T15:47:00.244430262Z Executing redis-8.0.3-r0.pre-install
2025-09-17T15:47:00.287651766Z Executing redis-8.0.3-r0.post-install
2025-09-17T15:47:00.296695737Z Executing busybox-1.37.0-r19.trigger
2025-09-17T15:47:00.311399886Z OK: 427 MiB in 116 packages
2025-09-17T15:47:00.400956842Z s6-rc: info: service init-mods-package-install successfully started
2025-09-17T15:47:00.401204220Z s6-rc: info: service init-mods-end: starting
2025-09-17T15:47:00.403335542Z s6-rc: info: service init-mods-end successfully started
2025-09-17T15:47:00.403487228Z s6-rc: info: service init-custom-files: starting
2025-09-17T15:47:00.411522408Z [custom-init] No custom files found, skipping...
2025-09-17T15:47:00.412201265Z s6-rc: info: service init-custom-files successfully started
2025-09-17T15:47:00.412367389Z s6-rc: info: service init-services: starting
2025-09-17T15:47:00.414178125Z s6-rc: info: service init-services successfully started
2025-09-17T15:47:00.414326234Z s6-rc: info: service svc-mod-universal-redis: starting
2025-09-17T15:47:00.414502318Z s6-rc: info: service svc-manyfold: starting
2025-09-17T15:47:00.414694174Z s6-rc: info: service svc-cron: starting
2025-09-17T15:47:00.417363079Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-09-17T15:47:00.418244403Z s6-rc: info: service svc-cron successfully started
2025-09-17T15:47:00.432612536Z 280:C 17 Sep 2025 15:47:00.432 # WARNING Memory overcommit must be enabled! Without it, a background save or replication may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
2025-09-17T15:47:00.432641184Z 280:C 17 Sep 2025 15:47:00.432 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-09-17T15:47:00.432650964Z 280:C 17 Sep 2025 15:47:00.432 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=280, just started
2025-09-17T15:47:00.432659651Z 280:C 17 Sep 2025 15:47:00.432 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-09-17T15:47:00.433587870Z 280:M 17 Sep 2025 15:47:00.433 * monotonic clock: POSIX clock_gettime
2025-09-17T15:47:00.434226947Z 280:M 17 Sep 2025 15:47:00.434 * Running mode=standalone, port=6379.
2025-09-17T15:47:00.434688306Z 280:M 17 Sep 2025 15:47:00.434 * Server initialized
2025-09-17T15:47:00.434712375Z 280:M 17 Sep 2025 15:47:00.434 * Ready to accept connections tcp
2025-09-17T15:47:00.573845791Z 15:47:00 rails.1              | started with pid 301
2025-09-17T15:47:00.573882845Z 15:47:00 default_worker.1     | started with pid 302
2025-09-17T15:47:00.573926403Z 15:47:00 performance_worker.1 | started with pid 303
2025-09-17T15:47:01.816232295Z 15:47:01 rails.1              | `/root` is not writable.
2025-09-17T15:47:01.816272395Z 15:47:01 rails.1              | Bundler will use `/tmp/bundler20250917-301-uf71ri301' as your home directory temporarily.
2025-09-17T15:47:02.261327021Z 15:47:02 default_worker.1     | `/root` is not writable.
2025-09-17T15:47:02.261371691Z 15:47:02 default_worker.1     | Bundler will use `/tmp/bundler20250917-302-ws8izd302' as your home directory temporarily.
2025-09-17T15:47:02.275011507Z 15:47:02 performance_worker.1 | `/root` is not writable.
2025-09-17T15:47:02.275045235Z 15:47:02 performance_worker.1 | Bundler will use `/tmp/bundler20250917-303-o06wxw303' as your home directory temporarily.
2025-09-17T15:47:02.826472307Z 15:47:02 rails.1              | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-17T15:47:02.826518871Z 15:47:02 rails.1              | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-17T15:47:02.826557288Z 15:47:02 rails.1              | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-17T15:47:03.115424015Z 15:47:03 rails.1              | => Booting Puma
2025-09-17T15:47:03.115466711Z 15:47:03 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-09-17T15:47:03.115513375Z 15:47:03 rails.1              | => Run `bin/rails server --help` for more startup options
2025-09-17T15:47:03.242752962Z 15:47:03 performance_worker.1 | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-17T15:47:03.242792110Z 15:47:03 performance_worker.1 | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-17T15:47:03.242802110Z 15:47:03 performance_worker.1 | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-17T15:47:03.253124897Z 15:47:03 default_worker.1     | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-09-17T15:47:03.253163645Z 15:47:03 default_worker.1     | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-17T15:47:03.253245660Z 15:47:03 default_worker.1     | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-17T15:47:03.694426926Z 15:47:03 performance_worker.1 | Server: 8c71e77ca183, Context: rails, Role: web, data: {cpu: {one_min: 3.11, five_min: 1.72, fifteen_min: 1.28}, memory: 0.182468608e9, disk: {available: 847938924544, total: 938656133120, used: 90717208576}}
2025-09-17T15:47:03.713400582Z 15:47:03 default_worker.1     | Server: 8c71e77ca183, Context: rails, Role: web, data: {cpu: {one_min: 3.11, five_min: 1.72, fifteen_min: 1.28}, memory: 0.177651712e9, disk: {available: 847938924544, total: 938656133120, used: 90717208576}}
2025-09-17T15:47:05.700525110Z 15:47:05 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:05.701994950Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.701Z pid=303 tid=21j: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-17T15:47:05.707970663Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.707Z pid=303 tid=21j: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-17T15:47:05.709826480Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.709Z pid=303 tid=21j: Cron Jobs - added job with name clear-downloads in the namespace default
2025-09-17T15:47:05.717515112Z 15:47:05 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:05.718811913Z 15:47:05 default_worker.1     | INFO  2025-09-17T15:47:05.718Z pid=302 tid=21i: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-17T15:47:05.779198100Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.778Z pid=303 tid=21j: Booted Rails 8.0.2.1 application in production environment
2025-09-17T15:47:05.779225305Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.778Z pid=303 tid=21j: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-17T15:47:05.779247450Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.778Z pid=303 tid=21j: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-17T15:47:05.779291308Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.778Z pid=303 tid=21j: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-17T15:47:05.781971445Z 15:47:05 performance_worker.1 | INFO  2025-09-17T15:47:05.781Z pid=303 tid=21j: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-09-17T15:47:05.790276378Z 15:47:05 default_worker.1     | INFO  2025-09-17T15:47:05.789Z pid=302 tid=21i: Booted Rails 8.0.2.1 application in production environment
2025-09-17T15:47:05.790305306Z 15:47:05 default_worker.1     | INFO  2025-09-17T15:47:05.790Z pid=302 tid=21i: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-17T15:47:05.790367622Z 15:47:05 default_worker.1     | INFO  2025-09-17T15:47:05.790Z pid=302 tid=21i: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-17T15:47:05.790420598Z 15:47:05 default_worker.1     | INFO  2025-09-17T15:47:05.790Z pid=302 tid=21i: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-17T15:47:05.793225386Z 15:47:05 default_worker.1     | INFO  2025-09-17T15:47:05.793Z pid=302 tid=21i: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-09-17T15:47:05.864705242Z 15:47:05 rails.1              | Server: 8c71e77ca183, Context: rails, Role: web, data: {cpu: {one_min: 3.11, five_min: 1.72, fifteen_min: 1.28}, memory: 0.174383104e9, disk: {available: 847940079616, total: 938656133120, used: 90716053504}}
2025-09-17T15:47:05.869724709Z 15:47:05 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:05.869776443Z 15:47:05 rails.1              | INFO  2025-09-17T15:47:05.705Z pid=301 tid=2bp: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-17T15:47:05.869806915Z 15:47:05 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 878fe44e-0496-4a21-b112-a272577616e2) to Sidekiq(upgrade)
2025-09-17T15:47:05.869834590Z 15:47:05 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: f9fd341f-43ca-43d0-a9df-bbeed3745e06) to Sidekiq(upgrade)
2025-09-17T15:47:05.869860823Z 15:47:05 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: df7158f0-1816-4c66-8eab-a7317014b9f1) to Sidekiq(upgrade)
2025-09-17T15:47:05.869887527Z 15:47:05 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: d101609c-1b16-408b-9960-16f8443db977) to Sidekiq(upgrade)
2025-09-17T15:47:05.869942959Z 15:47:05 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 6731f1a8-b6c0-4d62-9839-40614bf06087) to Sidekiq(upgrade)
2025-09-17T15:47:05.869948029Z 15:47:05 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: 79855c66-f4ba-45fd-a87f-0c06b1c18e66) to Sidekiq(upgrade)
2025-09-17T15:47:05.869977358Z 15:47:05 rails.1              | [301] Puma starting in cluster mode...
2025-09-17T15:47:05.870008992Z 15:47:05 rails.1              | [301] * Puma version: 7.0.3 ("Romantic Warrior")
2025-09-17T15:47:05.870030254Z 15:47:05 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-17T15:47:05.870058411Z 15:47:05 rails.1              | [301] *  Min threads: 4
2025-09-17T15:47:05.870074223Z 15:47:05 rails.1              | [301] *  Max threads: 16
2025-09-17T15:47:05.870114304Z 15:47:05 rails.1              | [301] *  Environment: production
2025-09-17T15:47:05.870134695Z 15:47:05 rails.1              | [301] *   Master PID: 301
2025-09-17T15:47:05.870171048Z 15:47:05 rails.1              | [301] *      Workers: 4
2025-09-17T15:47:05.870209495Z 15:47:05 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-09-17T15:47:05.870216900Z 15:47:05 rails.1              | [301] * Preloading application
2025-09-17T15:47:05.870248494Z 15:47:05 rails.1              | [301] * Listening on http://[::]:3214
2025-09-17T15:47:05.870295488Z 15:47:05 rails.1              | [301] Use Ctrl-C to stop
2025-09-17T15:47:05.895078603Z 15:47:05 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-09-17T15:47:05.895109856Z 15:47:05 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.02s, phase: 0
2025-09-17T15:47:05.895179045Z 15:47:05 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-09-17T15:47:05.896709607Z 15:47:05 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-09-17T15:47:06.052148097Z 15:47:06 default_worker.1     | Server: 8c71e77ca183, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.42, five_min: 1.81, fifteen_min: 1.31}, memory: 0.219602944e9, disk: {available: 847932731392, total: 938656133120, used: 90723401728}}
2025-09-17T15:47:06.067137921Z 15:47:06 performance_worker.1 | Server: 8c71e77ca183, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.42, five_min: 1.81, fifteen_min: 1.31}, memory: 0.228204544e9, disk: {available: 847932731392, total: 938656133120, used: 90723401728}}
2025-09-17T15:47:06.141099343Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.140Z pid=302 tid=hdq jid=816660cd98e647064f63fffd class=Upgrade::FixNilFileSizeValues: start
2025-09-17T15:47:06.144150327Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [878fe44e-0496-4a21-b112-a272577616e2] Performing Upgrade::FixNilFileSizeValues (Job ID: 878fe44e-0496-4a21-b112-a272577616e2) from Sidekiq(upgrade) enqueued at 2025-09-17T15:47:05.721227067Z
2025-09-17T15:47:06.144475331Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.143Z pid=302 tid=h1a jid=22422f3bb1db47b6c111aa56 class=Upgrade::UpdateActorsJob: start
2025-09-17T15:47:06.148901163Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d101609c-1b16-408b-9960-16f8443db977] Performing Upgrade::UpdateActorsJob (Job ID: d101609c-1b16-408b-9960-16f8443db977) from Sidekiq(upgrade) enqueued at 2025-09-17T15:47:05.723658573Z
2025-09-17T15:47:06.161668152Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.141Z pid=302 tid=hce jid=5b3c25e5790bf34166faafa1 class=Upgrade::DisambiguateUsernamesJob: start
2025-09-17T15:47:06.162265635Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [df7158f0-1816-4c66-8eab-a7317014b9f1] Performing Upgrade::DisambiguateUsernamesJob (Job ID: df7158f0-1816-4c66-8eab-a7317014b9f1) from Sidekiq(upgrade) enqueued at 2025-09-17T15:47:05.722932370Z
2025-09-17T15:47:06.163206179Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.140Z pid=302 tid=hdi jid=fb6ca69e617111d9a535059e class=Upgrade::BackfillDataPackages: start
2025-09-17T15:47:06.170518233Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [f9fd341f-43ca-43d0-a9df-bbeed3745e06] Performing Upgrade::BackfillDataPackages (Job ID: f9fd341f-43ca-43d0-a9df-bbeed3745e06) from Sidekiq(upgrade) enqueued at 2025-09-17T15:47:05.722254886Z
2025-09-17T15:47:06.188920739Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [f9fd341f-43ca-43d0-a9df-bbeed3745e06] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:06.193782249Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d101609c-1b16-408b-9960-16f8443db977] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:06.227949890Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [df7158f0-1816-4c66-8eab-a7317014b9f1] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:06.452928539Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-09-17T15:47:06.454347967Z s6-rc: info: service svc-manyfold successfully started
2025-09-17T15:47:06.454646990Z s6-rc: info: service legacy-services: starting
2025-09-17T15:47:06.467090937Z s6-rc: info: service legacy-services successfully started
2025-09-17T15:47:06.467333987Z s6-rc: info: service ci-service-check: starting
2025-09-17T15:47:06.470986021Z [ls.io-init] done.
2025-09-17T15:47:06.471788106Z s6-rc: info: service ci-service-check successfully started
2025-09-17T15:47:06.511075857Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [878fe44e-0496-4a21-b112-a272577616e2] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:06.573977058Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [878fe44e-0496-4a21-b112-a272577616e2] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-17T15:47:06.605412569Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [878fe44e-0496-4a21-b112-a272577616e2] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.068
2025-09-17T15:47:06.606412713Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [f9fd341f-43ca-43d0-a9df-bbeed3745e06] Performed Upgrade::BackfillDataPackages (Job ID: f9fd341f-43ca-43d0-a9df-bbeed3745e06) from Sidekiq(upgrade) in 435.57ms
2025-09-17T15:47:06.607381153Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d101609c-1b16-408b-9960-16f8443db977] Performed Upgrade::UpdateActorsJob (Job ID: d101609c-1b16-408b-9960-16f8443db977) from Sidekiq(upgrade) in 455.79ms
2025-09-17T15:47:06.608414995Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.607Z pid=302 tid=hdi jid=fb6ca69e617111d9a535059e class=Upgrade::BackfillDataPackages elapsed=0.467: done
2025-09-17T15:47:06.609303885Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [df7158f0-1816-4c66-8eab-a7317014b9f1] Performed Upgrade::DisambiguateUsernamesJob (Job ID: df7158f0-1816-4c66-8eab-a7317014b9f1) from Sidekiq(upgrade) in 444.43ms
2025-09-17T15:47:06.609884073Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.608Z pid=302 tid=h1a jid=22422f3bb1db47b6c111aa56 class=Upgrade::UpdateActorsJob elapsed=0.464: done
2025-09-17T15:47:06.621620656Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [878fe44e-0496-4a21-b112-a272577616e2] Performed Upgrade::FixNilFileSizeValues (Job ID: 878fe44e-0496-4a21-b112-a272577616e2) from Sidekiq(upgrade) in 477.56ms
2025-09-17T15:47:06.621964699Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.609Z pid=302 tid=hdi jid=4fbbc9895c9e1a8341778d41 class=Upgrade::FixParentCollections: start
2025-09-17T15:47:06.624554494Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [6731f1a8-b6c0-4d62-9839-40614bf06087] Performing Upgrade::FixParentCollections (Job ID: 6731f1a8-b6c0-4d62-9839-40614bf06087) from Sidekiq(upgrade) enqueued at 2025-09-17T15:47:05.724338281Z
2025-09-17T15:47:06.625031454Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.616Z pid=302 tid=hce jid=5b3c25e5790bf34166faafa1 class=Upgrade::DisambiguateUsernamesJob elapsed=0.476: done
2025-09-17T15:47:06.625198972Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.621Z pid=302 tid=h1a jid=e87da26138160dfd4cc76fdc class=Upgrade::PruneOrphanedProblems: start
2025-09-17T15:47:06.626225268Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79855c66-f4ba-45fd-a87f-0c06b1c18e66] Performing Upgrade::PruneOrphanedProblems (Job ID: 79855c66-f4ba-45fd-a87f-0c06b1c18e66) from Sidekiq(upgrade) enqueued at 2025-09-17T15:47:05.725011748Z
2025-09-17T15:47:06.626822741Z 15:47:06 default_worker.1     | INFO  2025-09-17T15:47:06.623Z pid=302 tid=hdq jid=816660cd98e647064f63fffd class=Upgrade::FixNilFileSizeValues elapsed=0.483: done
2025-09-17T15:47:06.627762965Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [6731f1a8-b6c0-4d62-9839-40614bf06087] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:06.749103212Z 15:47:06 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79855c66-f4ba-45fd-a87f-0c06b1c18e66] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-17T15:47:07.002828877Z 15:47:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79855c66-f4ba-45fd-a87f-0c06b1c18e66] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-17T15:47:07.004611146Z 15:47:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79855c66-f4ba-45fd-a87f-0c06b1c18e66] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.129
2025-09-17T15:47:07.008160543Z 15:47:07 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [6731f1a8-b6c0-4d62-9839-40614bf06087] Performed Upgrade::FixParentCollections (Job ID: 6731f1a8-b6c0-4d62-9839-40614bf06087) from Sidekiq(upgrade) in 383.34ms
2025-09-17T15:47:07.030978030Z 15:47:07 default_worker.1     | INFO  2025-09-17T15:47:07.030Z pid=302 tid=hdi jid=4fbbc9895c9e1a8341778d41 class=Upgrade::FixParentCollections elapsed=0.421: done
2025-09-17T15:47:07.032810169Z 15:47:07 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79855c66-f4ba-45fd-a87f-0c06b1c18e66] Performed Upgrade::PruneOrphanedProblems (Job ID: 79855c66-f4ba-45fd-a87f-0c06b1c18e66) from Sidekiq(upgrade) in 406.58ms
2025-09-17T15:47:07.047055805Z 15:47:07 default_worker.1     | INFO  2025-09-17T15:47:07.046Z pid=302 tid=h1a jid=e87da26138160dfd4cc76fdc class=Upgrade::PruneOrphanedProblems elapsed=0.425: done
2025-09-17T15:47:36.555202837Z 15:47:36 rails.1              | [6d90dd20-3bb1-42c1-b292-c27066226b57] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1392,"duration":31.81,"view":0.0,"db":4.93,"@timestamp":"2025-09-17T15:47:36.553Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-17T15:47:37.624783241Z 15:47:37 rails.1              | [b448c1b9-abd2-483d-92c9-7bb466ee2373] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":124441,"duration":1044.77,"view":0.0,"db":33.51,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-17T15:47:37.624Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-17T15:47:37.699714366Z 15:47:37 rails.1              | [d2b471a1-cf4a-4022-8e3b-232d24ae0dd5] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1071,"duration":43.19,"view":0.0,"db":2.56,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-17T15:47:37.679Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-17T15:47:38.449803866Z 15:47:38 rails.1              | [e83ce036-fc7a-45b4-9422-2f274aaeee3d] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":23856,"duration":713.42,"view":549.07,"db":68.4,"@timestamp":"2025-09-17T15:47:38.449Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-09-17T15:47:38.530998444Z 15:47:38 rails.1              | [b74ae1ec-1171-41be-b7b8-aa09b7f7e2c2] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":2087,"duration":38.77,"view":0.0,"db":4.41,"@timestamp":"2025-09-17T15:47:38.529Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-17T15:47:38.884556237Z 15:47:38 rails.1              | [fd635943-d304-4a91-992d-5e14d7e390ef] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14541,"duration":238.73,"view":0.0,"db":1.37,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-17T15:47:38.848Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-17T15:47:38.943063791Z 15:47:38 rails.1              | [4f0f6104-367c-458b-a7dd-b20f55d3932d] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1110,"duration":49.12,"view":0.0,"db":4.19,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-17T15:47:38.942Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-17T15:47:39.325935642Z 15:47:39 rails.1              | [fe160741-5ad4-40d5-bca0-fbdd64d7c144] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24097,"duration":355.28,"view":210.81,"db":1.17,"@timestamp":"2025-09-17T15:47:39.320Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}