2025-09-22T10:23:11.915743132Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-09-22T10:23:11.915985971Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-09-22T10:23:11.959148408Z [mod-init] Running Docker Modification Logic
2025-09-22T10:23:12.217486402Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-09-22T10:23:13.091252745Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-09-22T10:23:13.355303403Z [mod-init] Installing linuxserver/mods:universal-redis
2025-09-22T10:23:13.381146834Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-09-22T10:23:13.382229804Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-09-22T10:23:13.403681251Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-09-22T10:23:13.420548547Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-09-22T10:23:13.420768971Z s6-rc: info: service fix-attrs: starting
2025-09-22T10:23:13.420942831Z s6-rc: info: service init-migrations: starting
2025-09-22T10:23:13.421354740Z s6-rc: info: service init-envfile: starting
2025-09-22T10:23:13.427265502Z [migrations] started
2025-09-22T10:23:13.427329672Z [migrations] no migrations found
2025-09-22T10:23:13.427797774Z s6-rc: info: service init-migrations successfully started
2025-09-22T10:23:13.428031876Z s6-rc: info: service init-adduser: starting
2025-09-22T10:23:13.429046679Z s6-rc: info: service fix-attrs successfully started
2025-09-22T10:23:13.429237954Z s6-rc: info: service legacy-cont-init: starting
2025-09-22T10:23:13.431593939Z s6-rc: info: service init-envfile successfully started
2025-09-22T10:23:13.434842230Z s6-rc: info: service legacy-cont-init successfully started
2025-09-22T10:23:13.453846198Z usermod: no changes
2025-09-22T10:23:13.461304246Z ───────────────────────────────────────
2025-09-22T10:23:13.461313685Z 
2025-09-22T10:23:13.461317373Z       ██╗     ███████╗██╗ ██████╗
2025-09-22T10:23:13.461321241Z       ██║     ██╔════╝██║██╔═══██╗
2025-09-22T10:23:13.461325249Z       ██║     ███████╗██║██║   ██║
2025-09-22T10:23:13.461329157Z       ██║     ╚════██║██║██║   ██║
2025-09-22T10:23:13.461333195Z       ███████╗███████║██║╚██████╔╝
2025-09-22T10:23:13.461337022Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-09-22T10:23:13.461340920Z 
2025-09-22T10:23:13.461344698Z    Brought to you by linuxserver.io
2025-09-22T10:23:13.461358516Z ───────────────────────────────────────
2025-09-22T10:23:13.461695805Z 
2025-09-22T10:23:13.461715004Z To support LSIO projects visit:
2025-09-22T10:23:13.461724182Z https://www.linuxserver.io/donate/
2025-09-22T10:23:13.461732619Z 
2025-09-22T10:23:13.461740705Z ───────────────────────────────────────
2025-09-22T10:23:13.461749703Z GID/UID
2025-09-22T10:23:13.461758832Z ───────────────────────────────────────
2025-09-22T10:23:13.466389026Z 
2025-09-22T10:23:13.466395048Z User UID:    911
2025-09-22T10:23:13.466398645Z User GID:    911
2025-09-22T10:23:13.466402212Z ───────────────────────────────────────
2025-09-22T10:23:13.468873378Z Linuxserver.io version: v0.123.2-pkg-e6e6b235-dev-cdfc3a53da06754fc05a7471f5de6f48ef3da1d3-pr-14
2025-09-22T10:23:13.469307002Z Build-date: 2025-09-22T10:12:13+00:00
2025-09-22T10:23:13.469311120Z ───────────────────────────────────────
2025-09-22T10:23:13.469314908Z     
2025-09-22T10:23:13.485091397Z s6-rc: info: service init-adduser successfully started
2025-09-22T10:23:13.485224896Z s6-rc: info: service init-device-perms: starting
2025-09-22T10:23:13.490366359Z s6-rc: info: service init-device-perms successfully started
2025-09-22T10:23:13.490498585Z s6-rc: info: service init-os-end: starting
2025-09-22T10:23:13.491518288Z s6-rc: info: service init-os-end successfully started
2025-09-22T10:23:13.491639603Z s6-rc: info: service init-manyfold-config: starting
2025-09-22T10:23:13.491764855Z s6-rc: info: service init-config: starting
2025-09-22T10:23:13.493371881Z s6-rc: info: service init-config successfully started
2025-09-22T10:23:13.493494718Z s6-rc: info: service init-crontab-config: starting
2025-09-22T10:23:13.506060171Z s6-rc: info: service init-crontab-config successfully started
2025-09-22T10:23:13.521609994Z **** Running Manyfold database init. ****
2025-09-22T10:23:15.806225701Z `/root` is not writable.
2025-09-22T10:23:15.806390863Z Bundler will use `/tmp/bundler20250922-173-rnq2ft173' as your home directory temporarily.
2025-09-22T10:23:18.634023982Z /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-22T10:23:18.634054503Z You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T10:23:18.634060996Z Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T10:23:22.821192872Z Server: eb72cd62e4a0, Context: rails, Role: web, data: {cpu: {one_min: 4.28, five_min: 3.01, fifteen_min: 2.32}, memory: 0.19492864e9, disk: {available: 835629649920, total: 938656133120, used: 103026483200}}
2025-09-22T10:23:22.821237933Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-09-22T10:23:22.821248544Z INFO  2025-09-22T10:23:20.897Z pid=173 tid=2i5: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T10:23:22.821258725Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-09-22T10:23:22.821267713Z Migrating to CreateLibraries (20210130201037)
2025-09-22T10:23:22.821275940Z == 20210130201037 CreateLibraries: migrating ==================================
2025-09-22T10:23:22.821284296Z -- create_table(:libraries)
2025-09-22T10:23:22.821292413Z    -> 0.0034s
2025-09-22T10:23:22.821300569Z == 20210130201037 CreateLibraries: migrated (0.0035s) =========================
2025-09-22T10:23:22.821308796Z 
2025-09-22T10:23:22.821316682Z Migrating to CreateModels (20210130203243)
2025-09-22T10:23:22.821325109Z == 20210130203243 CreateModels: migrating =====================================
2025-09-22T10:23:22.821333295Z -- create_table(:models)
2025-09-22T10:23:22.821341552Z    -> 0.0009s
2025-09-22T10:23:22.821350059Z == 20210130203243 CreateModels: migrated (0.0010s) ============================
2025-09-22T10:23:22.821358225Z 
2025-09-22T10:23:22.821366762Z Migrating to CreateParts (20210205230918)
2025-09-22T10:23:22.821374989Z == 20210205230918 CreateParts: migrating ======================================
2025-09-22T10:23:22.821383276Z -- create_table(:parts)
2025-09-22T10:23:22.821391953Z    -> 0.0038s
2025-09-22T10:23:22.821399939Z == 20210205230918 CreateParts: migrated (0.0038s) =============================
2025-09-22T10:23:22.821408186Z 
2025-09-22T10:23:22.821416152Z Migrating to AddFieldsToParts (20210210153744)
2025-09-22T10:23:22.821424178Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-09-22T10:23:22.821432385Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-09-22T10:23:22.821440511Z    -> 0.0008s
2025-09-22T10:23:22.821448487Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-09-22T10:23:22.821456904Z    -> 0.0003s
2025-09-22T10:23:22.821464840Z == 20210210153744 AddFieldsToParts: migrated (0.0011s) ========================
2025-09-22T10:23:22.821473287Z 
2025-09-22T10:23:22.821481333Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-09-22T10:23:22.821489720Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-09-22T10:23:22.821513217Z -- create_table(:tags, {id: :integer})
2025-09-22T10:23:22.821521254Z    -> 0.0039s
2025-09-22T10:23:22.821529159Z -- create_table(:taggings, {id: :integer})
2025-09-22T10:23:22.821537546Z    -> 0.0018s
2025-09-22T10:23:22.821545522Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T10:23:22.821553789Z    -> 0.0002s
2025-09-22T10:23:22.821562988Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-22T10:23:22.821571575Z    -> 0.0022s
2025-09-22T10:23:22.821579611Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0083s) ===============
2025-09-22T10:23:22.821588058Z 
2025-09-22T10:23:22.821596044Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-09-22T10:23:22.821604722Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-09-22T10:23:22.821613058Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-09-22T10:23:22.821621746Z    -> 0.0003s
2025-09-22T10:23:22.821629592Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T10:23:22.821637778Z    -> 0.0004s
2025-09-22T10:23:22.821645594Z -- remove_foreign_key(:taggings, :tags)
2025-09-22T10:23:22.821653600Z    -> 0.1749s
2025-09-22T10:23:22.821661817Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T10:23:22.821670484Z    -> 0.0151s
2025-09-22T10:23:22.821678340Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-09-22T10:23:22.821686516Z    -> 0.0002s
2025-09-22T10:23:22.821694703Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-09-22T10:23:22.821703430Z    -> 0.0050s
2025-09-22T10:23:22.821711356Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-09-22T10:23:22.821719703Z    -> 0.0741s
2025-09-22T10:23:22.821727569Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3024s) =================
2025-09-22T10:23:22.821735846Z 
2025-09-22T10:23:22.821743531Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-09-22T10:23:22.821751557Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-09-22T10:23:22.821759814Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-09-22T10:23:22.821768441Z    -> 0.0381s
2025-09-22T10:23:22.821776999Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1232s) ===========
2025-09-22T10:23:22.821785005Z 
2025-09-22T10:23:22.821793021Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-09-22T10:23:22.821811528Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-09-22T10:23:22.821819795Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-22T10:23:22.821828492Z    -> 0.0003s
2025-09-22T10:23:22.821836498Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-09-22T10:23:22.821844695Z 
2025-09-22T10:23:22.821852601Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-09-22T10:23:22.821861008Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-09-22T10:23:22.821869194Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0007s) ==============
2025-09-22T10:23:22.821878182Z 
2025-09-22T10:23:22.821886489Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-09-22T10:23:22.821894686Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-09-22T10:23:22.821903333Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T10:23:22.821911750Z    -> 0.0078s
2025-09-22T10:23:22.821919626Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-22T10:23:22.821929566Z    -> 0.0002s
2025-09-22T10:23:22.821937412Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-22T10:23:22.821946009Z    -> 0.0059s
2025-09-22T10:23:22.821953885Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-22T10:23:22.821962011Z    -> 0.0013s
2025-09-22T10:23:22.821969787Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-22T10:23:22.821978073Z    -> 0.0004s
2025-09-22T10:23:22.821986410Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-22T10:23:22.821995138Z    -> 0.0001s
2025-09-22T10:23:22.822002934Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-22T10:23:22.822011781Z    -> 0.0040s
2025-09-22T10:23:22.822019587Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-22T10:23:22.822028074Z    -> 0.0002s
2025-09-22T10:23:22.822036321Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-22T10:23:22.822044347Z    -> 0.0005s
2025-09-22T10:23:22.822052393Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-22T10:23:22.822060530Z    -> 0.0002s
2025-09-22T10:23:22.822068646Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-22T10:23:22.822086622Z    -> 0.0006s
2025-09-22T10:23:22.822094498Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-22T10:23:22.822102735Z    -> 0.0001s
2025-09-22T10:23:22.822110600Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-22T10:23:22.822119558Z    -> 0.0015s
2025-09-22T10:23:22.822127685Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-22T10:23:22.822136232Z    -> 0.0002s
2025-09-22T10:23:22.822144268Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0233s) =============
2025-09-22T10:23:22.822152705Z 
2025-09-22T10:23:22.822160401Z Migrating to AddPreviewPartToModel (20210220204055)
2025-09-22T10:23:22.822168277Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-09-22T10:23:22.822176243Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-09-22T10:23:22.822184579Z    -> 0.2654s
2025-09-22T10:23:22.822192425Z == 20210220204055 AddPreviewPartToModel: migrated (0.2655s) ===================
2025-09-22T10:23:22.822200391Z 
2025-09-22T10:23:22.822208017Z Migrating to CreateCreators (20210225232756)
2025-09-22T10:23:22.822215882Z == 20210225232756 CreateCreators: migrating ===================================
2025-09-22T10:23:22.822223899Z -- create_table(:creators)
2025-09-22T10:23:22.822231774Z    -> 0.0155s
2025-09-22T10:23:22.822239670Z == 20210225232756 CreateCreators: migrated (0.0156s) ==========================
2025-09-22T10:23:22.822248117Z 
2025-09-22T10:23:22.822256344Z Migrating to AddCreatorToModels (20210225232841)
2025-09-22T10:23:22.822264741Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-09-22T10:23:22.822272767Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-09-22T10:23:22.822281124Z    -> 0.0567s
2025-09-22T10:23:22.822288980Z == 20210225232841 AddCreatorToModels: migrated (0.0567s) ======================
2025-09-22T10:23:22.822297266Z 
2025-09-22T10:23:22.822305192Z Migrating to CreateLinks (20210301230017)
2025-09-22T10:23:22.822313429Z == 20210301230017 CreateLinks: migrating ======================================
2025-09-22T10:23:22.822321405Z -- create_table(:links)
2025-09-22T10:23:22.822329501Z    -> 0.0007s
2025-09-22T10:23:22.822337297Z == 20210301230017 CreateLinks: migrated (0.0008s) =============================
2025-09-22T10:23:22.822345373Z 
2025-09-22T10:23:22.822353049Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-09-22T10:23:22.822360955Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-09-22T10:23:22.822378770Z -- remove_column(:creators, :thingiverse_user, :string)
2025-09-22T10:23:22.822386787Z    -> 0.0739s
2025-09-22T10:23:22.822394582Z -- remove_column(:creators, :cults3d_user, :string)
2025-09-22T10:23:22.822402929Z    -> 0.0048s
2025-09-22T10:23:22.822410895Z -- remove_column(:creators, :mmf_user, :string)
2025-09-22T10:23:22.822418921Z    -> 0.0150s
2025-09-22T10:23:22.822426727Z -- remove_column(:creators, :cgtrader_user, :string)
2025-09-22T10:23:22.822435304Z    -> 0.0037s
2025-09-22T10:23:22.822443621Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0999s) ==============
2025-09-22T10:23:22.822451607Z 
2025-09-22T10:23:22.822459733Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-09-22T10:23:22.822468010Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-09-22T10:23:22.822476086Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-09-22T10:23:22.822484614Z    -> 0.0645s
2025-09-22T10:23:22.822492479Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0646s) ==
2025-09-22T10:23:22.822500846Z 
2025-09-22T10:23:22.822508822Z Migrating to AddYUpToParts (20210318202638)
2025-09-22T10:23:22.822516758Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-09-22T10:23:22.822524684Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-09-22T10:23:22.822532640Z    -> 0.0162s
2025-09-22T10:23:22.822540456Z == 20210318202638 AddYUpToParts: migrated (0.0163s) ===========================
2025-09-22T10:23:22.822548793Z 
2025-09-22T10:23:22.822556498Z Migrating to CreateImages (20210321164508)
2025-09-22T10:23:22.822565216Z == 20210321164508 CreateImages: migrating =====================================
2025-09-22T10:23:22.822573503Z -- create_table(:images)
2025-09-22T10:23:22.822581338Z    -> 0.0173s
2025-09-22T10:23:22.822589124Z == 20210321164508 CreateImages: migrated (0.0173s) ============================
2025-09-22T10:23:22.822597341Z 
2025-09-22T10:23:22.822605026Z Migrating to CreateDelayedJobs (20210330215825)
2025-09-22T10:23:22.822613463Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-09-22T10:23:22.822621469Z -- create_table(:delayed_jobs)
2025-09-22T10:23:22.822629505Z    -> 0.0090s
2025-09-22T10:23:23.821294985Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-09-22T10:23:23.821335546Z    -> 0.0002s
2025-09-22T10:23:23.821345136Z == 20210330215825 CreateDelayedJobs: migrated (0.0107s) =======================
2025-09-22T10:23:23.821379615Z 
2025-09-22T10:23:23.821388253Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-09-22T10:23:23.821396770Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-09-22T10:23:23.821404976Z -- rename_table(:parts, :model_files)
2025-09-22T10:23:23.821413533Z    -> 0.0018s
2025-09-22T10:23:23.821421750Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-09-22T10:23:23.821429796Z    -> 0.0378s
2025-09-22T10:23:23.821437732Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0397s) =================
2025-09-22T10:23:23.821445859Z 
2025-09-22T10:23:23.821453945Z Migrating to RemoveImagesTable (20220106220519)
2025-09-22T10:23:23.821461951Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-09-22T10:23:23.821469997Z -- drop_table(:images)
2025-09-22T10:23:23.821477913Z    -> 0.0003s
2025-09-22T10:23:23.821485769Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-09-22T10:23:23.821493805Z 
2025-09-22T10:23:23.821501541Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-09-22T10:23:23.821509577Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-09-22T10:23:23.821518084Z -- table_exists?(:active_storage_blobs)
2025-09-22T10:23:23.821526301Z    -> 0.0001s
2025-09-22T10:23:23.821534227Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0002s) ======
2025-09-22T10:23:23.821542343Z 
2025-09-22T10:23:23.821550098Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-09-22T10:23:23.821558626Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-09-22T10:23:23.821566652Z -- table_exists?(:active_storage_blobs)
2025-09-22T10:23:23.821574518Z    -> 0.0001s
2025-09-22T10:23:23.821582774Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0002s) =======
2025-09-22T10:23:23.821590871Z 
2025-09-22T10:23:23.821598686Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-09-22T10:23:23.821606903Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-09-22T10:23:23.821615059Z -- table_exists?(:active_storage_blobs)
2025-09-22T10:23:23.821623055Z    -> 0.0001s
2025-09-22T10:23:23.821630911Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-09-22T10:23:23.821638897Z 
2025-09-22T10:23:23.821647104Z Migrating to DeviseCreateUsers (20220614210023)
2025-09-22T10:23:23.821654990Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-09-22T10:23:23.821663026Z -- create_table(:users)
2025-09-22T10:23:23.821680561Z    -> 0.0011s
2025-09-22T10:23:23.821689219Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-09-22T10:23:23.821697565Z    -> 0.0015s
2025-09-22T10:23:23.821705642Z == 20220614210023 DeviseCreateUsers: migrated (0.0028s) =======================
2025-09-22T10:23:23.821713658Z 
2025-09-22T10:23:23.821721634Z Migrating to AddUsernameToUsers (20220614211256)
2025-09-22T10:23:23.821729840Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-09-22T10:23:23.821739179Z -- add_column(:users, :username, :string, {null: false})
2025-09-22T10:23:23.821747316Z    -> 0.0219s
2025-09-22T10:23:23.821755262Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-09-22T10:23:23.821763578Z    -> 0.0001s
2025-09-22T10:23:23.821771554Z == 20220614211256 AddUsernameToUsers: migrated (0.0221s) ======================
2025-09-22T10:23:23.821779871Z 
2025-09-22T10:23:23.821787677Z Migrating to AddAdminToUsers (20220614213902)
2025-09-22T10:23:23.821795573Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-09-22T10:23:23.821803569Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-22T10:23:23.821811896Z    -> 0.0005s
2025-09-22T10:23:23.821819751Z == 20220614213902 AddAdminToUsers: migrated (0.0006s) =========================
2025-09-22T10:23:23.821827778Z 
2025-09-22T10:23:23.821835623Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-09-22T10:23:23.821844331Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-09-22T10:23:23.821852828Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-09-22T10:23:23.821862457Z    -> 0.0010s
2025-09-22T10:23:23.821870694Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0011s) =============
2025-09-22T10:23:23.821879111Z 
2025-09-22T10:23:23.821886997Z Migrating to CreateSettings (20220619174307)
2025-09-22T10:23:23.821895534Z == 20220619174307 CreateSettings: migrating ===================================
2025-09-22T10:23:23.821903891Z -- create_table(:settings)
2025-09-22T10:23:23.821912188Z    -> 0.0027s
2025-09-22T10:23:23.821920484Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-09-22T10:23:23.821929402Z    -> 0.0002s
2025-09-22T10:23:23.821937509Z == 20220619174307 CreateSettings: migrated (0.0029s) ==========================
2025-09-22T10:23:23.821945795Z 
2025-09-22T10:23:23.821953922Z Migrating to AddScaleFactorToModels (20220626152444)
2025-09-22T10:23:23.821971206Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-09-22T10:23:23.821979764Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-09-22T10:23:23.821987790Z    -> 0.0102s
2025-09-22T10:23:23.821996117Z == 20220626152444 AddScaleFactorToModels: migrated (0.0124s) ==================
2025-09-22T10:23:23.822004103Z 
2025-09-22T10:23:23.822011798Z Migrating to AddDigestToModelFiles (20220702202932)
2025-09-22T10:23:23.822019774Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-09-22T10:23:23.822028091Z -- add_column(:model_files, :digest, :string)
2025-09-22T10:23:23.822035947Z    -> 0.0024s
2025-09-22T10:23:23.822043753Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-09-22T10:23:23.822051889Z    -> 0.0002s
2025-09-22T10:23:23.822059845Z == 20220702202932 AddDigestToModelFiles: migrated (0.0045s) ===================
2025-09-22T10:23:23.822067831Z 
2025-09-22T10:23:23.822075607Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-09-22T10:23:23.822083503Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-09-22T10:23:23.822091950Z -- 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-22T10:23:23.822103653Z    -> 0.0008s
2025-09-22T10:23:23.822111980Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0011s) ==============
2025-09-22T10:23:23.822120006Z 
2025-09-22T10:23:23.822128052Z Migrating to CreateProblems (20221210001132)
2025-09-22T10:23:23.822136068Z == 20221210001132 CreateProblems: migrating ===================================
2025-09-22T10:23:23.822144085Z -- create_table(:problems)
2025-09-22T10:23:23.822152031Z    -> 0.0008s
2025-09-22T10:23:23.822159936Z == 20221210001132 CreateProblems: migrated (0.0011s) ==========================
2025-09-22T10:23:23.822167943Z 
2025-09-22T10:23:23.822175909Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-09-22T10:23:23.822183855Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-09-22T10:23:23.822192121Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0160s) ========
2025-09-22T10:23:23.822200398Z 
2025-09-22T10:23:23.822208073Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-09-22T10:23:23.822215969Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-09-22T10:23:23.822224006Z -- create_table(:favorites, {force: true})
2025-09-22T10:23:23.822240960Z    -> 0.0040s
2025-09-22T10:23:23.822248886Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-09-22T10:23:23.822257313Z    -> 0.0001s
2025-09-22T10:23:23.822265218Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-09-22T10:23:23.822273625Z    -> 0.0001s
2025-09-22T10:23:23.822281772Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-09-22T10:23:23.822291191Z    -> 0.0001s
2025-09-22T10:23:23.822298997Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0048s) ================
2025-09-22T10:23:23.822307013Z 
2025-09-22T10:23:23.822314668Z Migrating to MovePrintedToFavorites (20221220223040)
2025-09-22T10:23:23.822322654Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-09-22T10:23:23.822330981Z == 20221220223040 MovePrintedToFavorites: migrated (0.3170s) ==================
2025-09-22T10:23:23.822338987Z 
2025-09-22T10:23:23.822346652Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-09-22T10:23:23.822354769Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-09-22T10:23:23.822362935Z -- remove_column(:model_files, :printed, :boolean)
2025-09-22T10:23:23.822372454Z    -> 0.0285s
2025-09-22T10:23:23.822380280Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0289s) ===============
2025-09-22T10:23:23.822388376Z 
2025-09-22T10:23:23.822396122Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-09-22T10:23:23.822404629Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-09-22T10:23:23.822412746Z -- add_column(:models, :notes, :text)
2025-09-22T10:23:23.822420902Z    -> 0.0013s
2025-09-22T10:23:23.822428958Z -- add_column(:models, :excerpt, :text)
2025-09-22T10:23:23.822437596Z    -> 0.0022s
2025-09-22T10:23:23.822445481Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0036s) =================
2025-09-22T10:23:23.822453508Z 
2025-09-22T10:23:23.822461664Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-09-22T10:23:23.822470692Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-09-22T10:23:23.822478889Z -- add_column(:creators, :notes, :text)
2025-09-22T10:23:23.822487035Z    -> 0.0008s
2025-09-22T10:23:23.822495192Z -- add_column(:creators, :excerpt, :text)
2025-09-22T10:23:23.822503588Z    -> 0.0005s
2025-09-22T10:23:23.822512156Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0013s) ===============
2025-09-22T10:23:23.822520483Z 
2025-09-22T10:23:23.822538549Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-09-22T10:23:23.822546785Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-09-22T10:23:23.822554902Z -- add_column(:model_files, :notes, :text)
2025-09-22T10:23:23.822563138Z    -> 0.0006s
2025-09-22T10:23:23.822571515Z -- add_column(:model_files, :excerpt, :text)
2025-09-22T10:23:23.822579692Z    -> 0.0005s
2025-09-22T10:23:23.822587818Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0012s) =============
2025-09-22T10:23:23.822596255Z 
2025-09-22T10:23:23.822604371Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-09-22T10:23:23.822612478Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-09-22T10:23:23.822620554Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0235s) =================
2025-09-22T10:23:23.822629151Z 
2025-09-22T10:23:23.822636837Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-09-22T10:23:23.822644763Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-09-22T10:23:23.822652749Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-09-22T10:23:23.822660935Z    -> 0.0454s
2025-09-22T10:23:23.822668871Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0455s) =============
2025-09-22T10:23:23.822676887Z 
2025-09-22T10:23:23.822684874Z Migrating to RenameExcerptToCaption (20230222155910)
2025-09-22T10:23:23.822692789Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-09-22T10:23:23.822700766Z -- rename_column(:creators, :excerpt, :caption)
2025-09-22T10:23:23.822708912Z    -> 0.0239s
2025-09-22T10:23:23.822716808Z -- rename_column(:models, :excerpt, :caption)
2025-09-22T10:23:23.822724714Z    -> 0.0229s
2025-09-22T10:23:23.822732930Z -- rename_column(:model_files, :excerpt, :caption)
2025-09-22T10:23:23.822740896Z    -> 0.0205s
2025-09-22T10:23:23.822748732Z == 20230222155910 RenameExcerptToCaption: migrated (0.0699s) ==================
2025-09-22T10:23:23.822756738Z 
2025-09-22T10:23:23.822764494Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-09-22T10:23:23.822772430Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-09-22T10:23:23.822780446Z -- add_column(:libraries, :notes, :string)
2025-09-22T10:23:23.822788362Z    -> 0.0021s
2025-09-22T10:23:23.822796338Z -- add_column(:libraries, :caption, :string)
2025-09-22T10:23:24.351337049Z    -> 0.0005s
2025-09-22T10:23:24.351381849Z -- add_column(:libraries, :name, :string)
2025-09-22T10:23:24.351411800Z    -> 0.0005s
2025-09-22T10:23:24.351420477Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0120s) ============
2025-09-22T10:23:24.351428724Z 
2025-09-22T10:23:24.351437020Z Migrating to AddTagregexToLibrary (20230305180823)
2025-09-22T10:23:24.351447251Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-09-22T10:23:24.351457943Z -- add_column(:libraries, :tag_regex, :text)
2025-09-22T10:23:24.351468494Z    -> 0.0019s
2025-09-22T10:23:24.351478584Z == 20230305180823 AddTagregexToLibrary: migrated (0.0035s) ====================
2025-09-22T10:23:24.351486811Z 
2025-09-22T10:23:24.351494737Z Migrating to AddIconToLibrary (20230307215826)
2025-09-22T10:23:24.351502783Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-09-22T10:23:24.351512583Z -- add_column(:libraries, :icon, :text)
2025-09-22T10:23:24.351523595Z    -> 0.0019s
2025-09-22T10:23:24.351533815Z == 20230307215826 AddIconToLibrary: migrated (0.0035s) ========================
2025-09-22T10:23:24.351542693Z 
2025-09-22T10:23:24.351550699Z Migrating to CreateCollection (20230308004237)
2025-09-22T10:23:24.351558906Z == 20230308004237 CreateCollection: migrating =================================
2025-09-22T10:23:24.351567473Z -- create_table(:collections)
2025-09-22T10:23:24.351575439Z    -> 0.0028s
2025-09-22T10:23:24.351583706Z == 20230308004237 CreateCollection: migrated (0.0069s) ========================
2025-09-22T10:23:24.351591902Z 
2025-09-22T10:23:24.351599638Z Migrating to AddCollectionToModels (20230308005021)
2025-09-22T10:23:24.351607544Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-09-22T10:23:24.351615800Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-09-22T10:23:24.351623877Z    -> 0.0176s
2025-09-22T10:23:24.351631763Z == 20230308005021 AddCollectionToModels: migrated (0.0213s) ===================
2025-09-22T10:23:24.351639939Z 
2025-09-22T10:23:24.351647715Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-09-22T10:23:24.351655961Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-09-22T10:23:24.351663977Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0015s) =============
2025-09-22T10:23:24.351672044Z 
2025-09-22T10:23:24.351679779Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-09-22T10:23:24.351688206Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-09-22T10:23:24.351696703Z -- rename_column(:collections, :excerpt, :caption)
2025-09-22T10:23:24.351705100Z    -> 0.0040s
2025-09-22T10:23:24.351713758Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0041s) ========
2025-09-22T10:23:24.351733758Z 
2025-09-22T10:23:24.351741944Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-09-22T10:23:24.351750101Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-09-22T10:23:24.351758277Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-09-22T10:23:24.351766895Z 
2025-09-22T10:23:24.351774720Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-09-22T10:23:24.351784410Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-09-22T10:23:24.351792777Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-09-22T10:23:24.351802907Z    -> 0.0019s
2025-09-22T10:23:24.351811244Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0020s) ===============
2025-09-22T10:23:24.351819410Z 
2025-09-22T10:23:24.351827517Z Migrating to AddCollectionToCollections (20230324000000)
2025-09-22T10:23:24.351835523Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-09-22T10:23:24.351843549Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-09-22T10:23:24.351874071Z    -> 0.0065s
2025-09-22T10:23:24.351884231Z == 20230324000000 AddCollectionToCollections: migrated (0.0087s) ==============
2025-09-22T10:23:24.351895243Z 
2025-09-22T10:23:24.351905013Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-09-22T10:23:24.351915273Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-09-22T10:23:24.351925524Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0425s) =========
2025-09-22T10:23:24.351935634Z 
2025-09-22T10:23:24.351945534Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-09-22T10:23:24.351956086Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-09-22T10:23:24.351966186Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0068s) 
2025-09-22T10:23:24.351976577Z 
2025-09-22T10:23:24.351987128Z Migrating to AddSlugs (20230615135601)
2025-09-22T10:23:24.351997279Z == 20230615135601 AddSlugs: migrating =========================================
2025-09-22T10:23:24.352005565Z -- add_column(:models, :slug, :string)
2025-09-22T10:23:24.352013682Z    -> 0.0030s
2025-09-22T10:23:24.352021608Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-09-22T10:23:24.352030225Z    -> 0.0024s
2025-09-22T10:23:24.352038091Z -- add_column(:collections, :slug, :string)
2025-09-22T10:23:24.352046087Z    -> 0.0005s
2025-09-22T10:23:24.352065616Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-09-22T10:23:24.352073913Z    -> 0.0002s
2025-09-22T10:23:24.352081769Z -- add_column(:creators, :slug, :string)
2025-09-22T10:23:24.352089695Z    -> 0.0005s
2025-09-22T10:23:24.352097530Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-09-22T10:23:24.352105717Z    -> 0.0001s
2025-09-22T10:23:24.352113603Z == 20230615135601 AddSlugs: migrated (0.0073s) ================================
2025-09-22T10:23:24.352124835Z 
2025-09-22T10:23:24.352132561Z Migrating to GenerateSlugs (20230617222353)
2025-09-22T10:23:24.352140687Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-09-22T10:23:24.352148663Z == 20230617222353 GenerateSlugs: migrated (0.0579s) ===========================
2025-09-22T10:23:24.352156700Z 
2025-09-22T10:23:24.352164445Z Migrating to MakeNamesUnique (20230628194944)
2025-09-22T10:23:24.352172341Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-09-22T10:23:24.352183544Z == 20230628194944 MakeNamesUnique: migrated (0.0032s) =========================
2025-09-22T10:23:24.352194446Z 
2025-09-22T10:23:24.352204326Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-09-22T10:23:24.352212372Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-09-22T10:23:24.352222272Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-09-22T10:23:24.352232552Z    -> 0.0026s
2025-09-22T10:23:24.352242332Z -- remove_index(:creators, :slug)
2025-09-22T10:23:24.352250549Z    -> 0.0004s
2025-09-22T10:23:24.352258374Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-09-22T10:23:24.352266881Z    -> 0.0001s
2025-09-22T10:23:24.352274737Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-09-22T10:23:24.352283194Z    -> 0.0001s
2025-09-22T10:23:24.352293104Z -- remove_index(:collections, :slug)
2025-09-22T10:23:24.352303405Z    -> 0.0249s
2025-09-22T10:23:24.352312543Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-09-22T10:23:24.352321321Z    -> 0.0006s
2025-09-22T10:23:24.352330961Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0293s) ======
2025-09-22T10:23:24.352341452Z 
2025-09-22T10:23:24.352351833Z Migrating to AddSizeToModelFiles (20230707082403)
2025-09-22T10:23:24.352362324Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-09-22T10:23:24.352372584Z -- add_column(:model_files, :size, :integer)
2025-09-22T10:23:24.352391983Z    -> 0.0006s
2025-09-22T10:23:24.352399939Z == 20230707082403 AddSizeToModelFiles: migrated (0.0010s) =====================
2025-09-22T10:23:24.352407956Z 
2025-09-22T10:23:24.352417034Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-09-22T10:23:24.352425361Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-09-22T10:23:24.352433667Z -- change_column(:model_files, :size, :bigint)
2025-09-22T10:23:24.352441573Z    -> 0.0084s
2025-09-22T10:23:24.352449529Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0087s) ==================
2025-09-22T10:23:24.352458056Z 
2025-09-22T10:23:24.352465922Z Migrating to AddNoteToProblems (20230711111009)
2025-09-22T10:23:24.352473938Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-09-22T10:23:24.352481904Z -- add_column(:problems, :note, :string, {default: nil})
2025-09-22T10:23:24.352490331Z    -> 0.0009s
2025-09-22T10:23:24.352498368Z == 20230711111009 AddNoteToProblems: migrated (0.0020s) =======================
2025-09-22T10:23:24.352506775Z 
2025-09-22T10:23:24.352514690Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-09-22T10:23:24.352522887Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-09-22T10:23:24.352532647Z -- 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-22T10:23:24.352547186Z    -> 0.0006s
2025-09-22T10:23:24.352557607Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-09-22T10:23:24.352568629Z 
2025-09-22T10:23:24.352578619Z Migrating to AddLicenseToModel (20240127143358)
2025-09-22T10:23:24.352589120Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-09-22T10:23:24.352599551Z -- add_column(:models, :license, :string)
2025-09-22T10:23:24.352610594Z    -> 0.0006s
2025-09-22T10:23:24.352621045Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-09-22T10:23:24.352631636Z 
2025-09-22T10:23:24.352641837Z Migrating to AddIgnoredToProblems (20240131134832)
2025-09-22T10:23:24.352652488Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-09-22T10:23:24.352663220Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-09-22T10:23:24.352674001Z    -> 0.0006s
2025-09-22T10:23:24.352699613Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-09-22T10:23:24.352710775Z 
2025-09-22T10:23:24.352720866Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-09-22T10:23:24.352731507Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-09-22T10:23:24.352741848Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-09-22T10:23:24.352752820Z    -> 0.0092s
2025-09-22T10:23:24.352763011Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0092s) ======
2025-09-22T10:23:24.352773632Z 
2025-09-22T10:23:24.352783812Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-09-22T10:23:24.352794294Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-09-22T10:23:24.352806007Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-09-22T10:23:24.352819314Z    -> 0.0007s
2025-09-22T10:23:24.352832450Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-09-22T10:23:24.352845697Z 
2025-09-22T10:23:24.352856298Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-09-22T10:23:24.352866940Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-09-22T10:23:24.352877200Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-09-22T10:23:24.352887732Z    -> 0.0003s
2025-09-22T10:23:24.352897832Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-09-22T10:23:24.352908654Z    -> 0.0010s
2025-09-22T10:23:24.352919275Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-09-22T10:23:24.352930848Z    -> 0.0001s
2025-09-22T10:23:24.352941019Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-09-22T10:23:24.352951931Z    -> 0.0045s
2025-09-22T10:23:24.922324906Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0061s) =================
2025-09-22T10:23:24.922369215Z 
2025-09-22T10:23:24.922378433Z Migrating to CreateFlipperTables (20240306095646)
2025-09-22T10:23:24.922386981Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-09-22T10:23:24.922395297Z -- create_table(:flipper_features)
2025-09-22T10:23:24.922403374Z    -> 0.0037s
2025-09-22T10:23:24.922412151Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-09-22T10:23:24.922420979Z    -> 0.0051s
2025-09-22T10:23:24.922449005Z -- create_table(:flipper_gates)
2025-09-22T10:23:24.922457132Z    -> 0.0003s
2025-09-22T10:23:24.922465158Z -- 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-22T10:23:24.922473805Z    -> 0.0001s
2025-09-22T10:23:24.922482202Z == 20240306095646 CreateFlipperTables: migrated (0.0094s) =====================
2025-09-22T10:23:24.922490349Z 
2025-09-22T10:23:24.922498235Z Migrating to RolifyCreateRoles (20240319155251)
2025-09-22T10:23:24.922506371Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-09-22T10:23:24.922514437Z -- create_table(:roles)
2025-09-22T10:23:24.922522533Z    -> 0.0415s
2025-09-22T10:23:24.922530429Z -- create_table(:users_roles, {id: false})
2025-09-22T10:23:24.922538335Z    -> 0.0005s
2025-09-22T10:23:24.922546442Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-09-22T10:23:24.922554698Z    -> 0.0055s
2025-09-22T10:23:24.922562995Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-09-22T10:23:24.922571452Z    -> 0.0002s
2025-09-22T10:23:24.922579548Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-09-22T10:23:24.922587985Z    -> 0.0001s
2025-09-22T10:23:24.922595871Z == 20240319155251 RolifyCreateRoles: migrated (0.0657s) =======================
2025-09-22T10:23:24.922604118Z 
2025-09-22T10:23:24.922612084Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-09-22T10:23:24.922620110Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-09-22T10:23:24.922628206Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0092s) ==================
2025-09-22T10:23:24.922636573Z 
2025-09-22T10:23:24.922644409Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-09-22T10:23:24.922652335Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-09-22T10:23:24.922660812Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-22T10:23:24.922668808Z    -> 0.0252s
2025-09-22T10:23:24.922676994Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0267s) ====================
2025-09-22T10:23:24.922685211Z 
2025-09-22T10:23:24.922693117Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-09-22T10:23:24.922701474Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-09-22T10:23:24.922710111Z -- add_column(:users, :reset_password_token, :string)
2025-09-22T10:23:24.922718127Z    -> 0.0012s
2025-09-22T10:23:24.922736424Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-09-22T10:23:24.922746304Z    -> 0.0002s
2025-09-22T10:23:24.922754541Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0037s) ============
2025-09-22T10:23:24.922762707Z 
2025-09-22T10:23:24.922771224Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-09-22T10:23:24.922779631Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-09-22T10:23:24.922787968Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0272s) ==============
2025-09-22T10:23:24.922796635Z 
2025-09-22T10:23:24.922804852Z Migrating to AddRememberableToUsers (20240410221112)
2025-09-22T10:23:24.922812858Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-09-22T10:23:24.922821285Z -- add_column(:users, :remember_created_at, :datetime)
2025-09-22T10:23:24.922829522Z    -> 0.0034s
2025-09-22T10:23:24.922837377Z == 20240410221112 AddRememberableToUsers: migrated (0.0047s) ==================
2025-09-22T10:23:24.922845444Z 
2025-09-22T10:23:24.922853460Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-09-22T10:23:24.922861937Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-09-22T10:23:24.922869983Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-09-22T10:23:24.922877929Z    -> 0.0006s
2025-09-22T10:23:24.922886246Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0019s) ===========
2025-09-22T10:23:24.922894252Z 
2025-09-22T10:23:24.922902008Z Migrating to DropDelayedJobs (20240418112821)
2025-09-22T10:23:24.922909893Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-09-22T10:23:24.922918190Z -- drop_table(:delayed_jobs)
2025-09-22T10:23:24.922926637Z    -> 0.0019s
2025-09-22T10:23:24.922934824Z == 20240418112821 DropDelayedJobs: migrated (0.0125s) =========================
2025-09-22T10:23:24.922942880Z 
2025-09-22T10:23:24.922951096Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-09-22T10:23:24.922959022Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-09-22T10:23:24.922967008Z -- add_column(:users, :interface_language, :string)
2025-09-22T10:23:24.922974914Z    -> 0.0008s
2025-09-22T10:23:24.922982850Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0045s) =============
2025-09-22T10:23:24.922990846Z 
2025-09-22T10:23:24.922998532Z Migrating to AddLockableToUsers (20240610120318)
2025-09-22T10:23:24.923006408Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-09-22T10:23:24.923014484Z -- change_table(:users)
2025-09-22T10:23:24.923031578Z    -> 0.0018s
2025-09-22T10:23:24.923039504Z == 20240610120318 AddLockableToUsers: migrated (0.0022s) ======================
2025-09-22T10:23:24.923047541Z 
2025-09-22T10:23:24.923055266Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-09-22T10:23:24.923063673Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-09-22T10:23:24.923071669Z -- add_column(:model_files, :attachment_data, :json)
2025-09-22T10:23:24.923079545Z    -> 0.0008s
2025-09-22T10:23:24.923087471Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0012s) ===========
2025-09-22T10:23:24.923095497Z 
2025-09-22T10:23:24.923103153Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-09-22T10:23:24.923111570Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-09-22T10:23:24.923119636Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0138s) ==================
2025-09-22T10:23:24.923127692Z 
2025-09-22T10:23:24.923135317Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-09-22T10:23:24.923143544Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-09-22T10:23:24.923151580Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-09-22T10:23:24.923159797Z    -> 0.0007s
2025-09-22T10:23:24.923167632Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0026s) ============
2025-09-22T10:23:24.923175619Z 
2025-09-22T10:23:24.923183304Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-09-22T10:23:24.923191230Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-09-22T10:23:24.923199256Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-09-22T10:23:24.923207302Z    -> 0.0010s
2025-09-22T10:23:24.923217663Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-09-22T10:23:24.923225890Z    -> 0.0007s
2025-09-22T10:23:24.923233916Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-09-22T10:23:24.923241932Z    -> 0.0007s
2025-09-22T10:23:24.923249778Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-09-22T10:23:24.923257964Z    -> 0.0055s
2025-09-22T10:23:24.923265810Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-09-22T10:23:24.923274097Z    -> 0.0006s
2025-09-22T10:23:24.923282634Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0103s) ====================
2025-09-22T10:23:24.923291171Z 
2025-09-22T10:23:24.923298917Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-09-22T10:23:24.923306843Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-09-22T10:23:24.923323867Z -- remove_index(:libraries, :path)
2025-09-22T10:23:24.923331843Z    -> 0.0013s
2025-09-22T10:23:24.923339709Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0021s) ================
2025-09-22T10:23:24.923347705Z 
2025-09-22T10:23:24.923355781Z Migrating to CreateFederailsActors (20240727113215)
2025-09-22T10:23:24.923363767Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-09-22T10:23:24.923371753Z -- create_table(:federails_actors)
2025-09-22T10:23:24.923379720Z    -> 0.0011s
2025-09-22T10:23:24.923387615Z -- foreign_key_exists?(:federails_actors, :users)
2025-09-22T10:23:24.923395531Z    -> 0.0016s
2025-09-22T10:23:24.923403437Z -- remove_foreign_key(:federails_actors, :users)
2025-09-22T10:23:24.923411343Z    -> 0.0195s
2025-09-22T10:23:24.923419279Z -- remove_index(:federails_actors, :user_id)
2025-09-22T10:23:24.923427245Z    -> 0.0008s
2025-09-22T10:23:24.923435171Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-09-22T10:23:24.923443478Z    -> 0.0001s
2025-09-22T10:23:24.923451364Z -- add_foreign_key(:federails_actors, :users)
2025-09-22T10:23:24.923459440Z    -> 0.0231s
2025-09-22T10:23:24.923467566Z == 20240727113215 CreateFederailsActors: migrated (0.0471s) ===================
2025-09-22T10:23:24.923475563Z 
2025-09-22T10:23:24.923483318Z Migrating to CreateFederailsFollowings (20240727113216)
2025-09-22T10:23:24.923491825Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-09-22T10:23:24.923499952Z -- create_table(:federails_followings)
2025-09-22T10:23:24.923507868Z    -> 0.0027s
2025-09-22T10:23:24.923515703Z == 20240727113216 CreateFederailsFollowings: migrated (0.0027s) ===============
2025-09-22T10:23:24.923524050Z 
2025-09-22T10:23:24.923531946Z Migrating to CreateFederailsActivities (20240727113217)
2025-09-22T10:23:24.923540183Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-09-22T10:23:24.923548810Z -- create_table(:federails_activities)
2025-09-22T10:23:24.923557487Z    -> 0.0098s
2025-09-22T10:23:24.923565564Z == 20240727113217 CreateFederailsActivities: migrated (0.0099s) ===============
2025-09-22T10:23:24.923574452Z 
2025-09-22T10:23:24.923582438Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-09-22T10:23:24.923590624Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-09-22T10:23:24.923598821Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-09-22T10:23:24.923616957Z    -> 0.0188s
2025-09-22T10:23:24.923625414Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-09-22T10:23:24.923634372Z    -> 0.0006s
2025-09-22T10:23:24.923642509Z -- change_table(:federails_actors)
2025-09-22T10:23:24.923650625Z    -> 0.0091s
2025-09-22T10:23:24.923658481Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0289s) =======
2025-09-22T10:23:24.923666818Z 
2025-09-22T10:23:24.923674523Z Migrating to CreateFederailsActors (20240731165647)
2025-09-22T10:23:24.923682690Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-09-22T10:23:24.923690776Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-09-22T10:23:24.923699043Z 
2025-09-22T10:23:24.923706788Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-09-22T10:23:24.923714714Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-09-22T10:23:24.923722911Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-09-22T10:23:24.923730917Z 
2025-09-22T10:23:24.923738592Z Migrating to BackfillActivities (20240805111500)
2025-09-22T10:23:24.923746518Z == 20240805111500 BackfillActivities: migrating ===============================
2025-09-22T10:23:24.923754554Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-09-22T10:23:24.923762550Z 
2025-09-22T10:23:24.923770266Z Migrating to CreateCaberRelations (20240827155630)
2025-09-22T10:23:24.923778162Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-09-22T10:23:24.923786348Z -- create_table(:caber_relations)
2025-09-22T10:23:24.923794194Z    -> 0.0431s
2025-09-22T10:23:24.923802060Z == 20240827155630 CreateCaberRelations: migrated (0.0432s) ====================
2025-09-22T10:23:24.923810266Z 
2025-09-22T10:23:24.923818453Z Migrating to AddDefaultAccessControls (20240830121749)
2025-09-22T10:23:24.923826389Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-09-22T10:23:24.923834656Z == 20240830121749 AddDefaultAccessControls: migrated (0.0251s) ================
2025-09-22T10:23:24.923842632Z 
2025-09-22T10:23:24.923868444Z Migrating to RenameDefaultRoles (20240830151650)
2025-09-22T10:23:25.579300515Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-09-22T10:23:25.579330025Z == 20240830151650 RenameDefaultRoles: migrated (0.0435s) ======================
2025-09-22T10:23:25.579334484Z 
2025-09-22T10:23:25.579338171Z Migrating to AddPublicIDsToModels (20240904151944)
2025-09-22T10:23:25.579342059Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-09-22T10:23:25.579358803Z -- add_column(:models, :public_id, :string)
2025-09-22T10:23:25.579362801Z    -> 0.0009s
2025-09-22T10:23:25.579366799Z -- add_index(:models, :public_id)
2025-09-22T10:23:25.579370406Z    -> 0.0027s
2025-09-22T10:23:25.579374093Z -- add_column(:model_files, :public_id, :string)
2025-09-22T10:23:25.579378152Z    -> 0.0007s
2025-09-22T10:23:25.579382390Z -- add_index(:model_files, :public_id)
2025-09-22T10:23:25.579386258Z    -> 0.0002s
2025-09-22T10:23:25.579389815Z -- add_column(:problems, :public_id, :string)
2025-09-22T10:23:25.579393593Z    -> 0.0007s
2025-09-22T10:23:25.579397320Z -- add_index(:problems, :public_id)
2025-09-22T10:23:25.579400887Z    -> 0.0001s
2025-09-22T10:23:25.579404695Z -- add_column(:creators, :public_id, :string)
2025-09-22T10:23:25.579408723Z    -> 0.0007s
2025-09-22T10:23:25.579412310Z -- add_index(:creators, :public_id)
2025-09-22T10:23:25.579415908Z    -> 0.0002s
2025-09-22T10:23:25.579419996Z -- add_column(:collections, :public_id, :string)
2025-09-22T10:23:25.579423844Z    -> 0.0007s
2025-09-22T10:23:25.579427371Z -- add_index(:collections, :public_id)
2025-09-22T10:23:25.579430928Z    -> 0.0001s
2025-09-22T10:23:25.579434495Z -- add_column(:libraries, :public_id, :string)
2025-09-22T10:23:25.579438303Z    -> 0.0007s
2025-09-22T10:23:25.579442060Z -- add_index(:libraries, :public_id)
2025-09-22T10:23:25.579445758Z    -> 0.0001s
2025-09-22T10:23:25.579449756Z == 20240904151944 AddPublicIDsToModels: migrated (0.0085s) ====================
2025-09-22T10:23:25.579453413Z 
2025-09-22T10:23:25.579457301Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-09-22T10:23:25.579461079Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-09-22T10:23:25.579464966Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:25.579468954Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0383s) ==============
2025-09-22T10:23:25.579472572Z 
2025-09-22T10:23:25.579476670Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-09-22T10:23:25.579480608Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-09-22T10:23:25.579484556Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-09-22T10:23:25.579488514Z 
2025-09-22T10:23:25.579492692Z Migrating to DeduplicateRoles (20240923114515)
2025-09-22T10:23:25.579496951Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-09-22T10:23:25.579506119Z == 20240923114515 DeduplicateRoles: migrated (0.1507s) ========================
2025-09-22T10:23:25.579509787Z 
2025-09-22T10:23:25.579513474Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-09-22T10:23:25.579517452Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-09-22T10:23:25.579521641Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-22T10:23:25.579525669Z    -> 0.0428s
2025-09-22T10:23:25.579530418Z -- add_index(:models, :name_lower)
2025-09-22T10:23:25.579534587Z    -> 0.0002s
2025-09-22T10:23:25.579538535Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-22T10:23:25.579542863Z    -> 0.1358s
2025-09-22T10:23:25.579546461Z -- add_index(:creators, :name_lower)
2025-09-22T10:23:25.579550058Z    -> 0.0002s
2025-09-22T10:23:25.579553645Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-22T10:23:25.579557352Z    -> 0.0100s
2025-09-22T10:23:25.579560900Z -- add_index(:collections, :name_lower)
2025-09-22T10:23:25.579565068Z    -> 0.0001s
2025-09-22T10:23:25.579568655Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1892s) =============
2025-09-22T10:23:25.579572303Z 
2025-09-22T10:23:25.579575770Z Migrating to AddKeypairToActors (20240926162407)
2025-09-22T10:23:25.579579387Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-09-22T10:23:25.579583024Z -- change_table(:federails_actors)
2025-09-22T10:23:25.579586581Z    -> 0.0015s
2025-09-22T10:23:25.579590149Z == 20240926162407 AddKeypairToActors: migrated (0.0015s) ======================
2025-09-22T10:23:25.579593776Z 
2025-09-22T10:23:25.579597593Z Migrating to AddUuids (20241004194445)
2025-09-22T10:23:25.579601171Z == 20241004194445 AddUuids: migrating =========================================
2025-09-22T10:23:25.579604768Z -- change_table(:federails_actors)
2025-09-22T10:23:25.579608325Z    -> 0.0031s
2025-09-22T10:23:25.579611892Z -- change_table(:federails_activities)
2025-09-22T10:23:25.579616041Z    -> 0.0009s
2025-09-22T10:23:25.579619608Z -- change_table(:federails_followings)
2025-09-22T10:23:25.579623175Z    -> 0.0009s
2025-09-22T10:23:25.579627023Z == 20241004194445 AddUuids: migrated (0.0049s) ================================
2025-09-22T10:23:25.579630660Z 
2025-09-22T10:23:25.579636011Z Migrating to CreateComments (20241007182824)
2025-09-22T10:23:25.579639678Z == 20241007182824 CreateComments: migrating ===================================
2025-09-22T10:23:25.579856425Z -- create_table(:comments)
2025-09-22T10:23:25.579862717Z    -> 0.0021s
2025-09-22T10:23:25.579866555Z == 20241007182824 CreateComments: migrated (0.0021s) ==========================
2025-09-22T10:23:25.579870223Z 
2025-09-22T10:23:25.579874201Z Migrating to AddSystemToComments (20241009122540)
2025-09-22T10:23:25.579877878Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-09-22T10:23:25.579881635Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-09-22T10:23:25.579885283Z    -> 0.0008s
2025-09-22T10:23:25.579888830Z == 20241009122540 AddSystemToComments: migrated (0.0008s) =====================
2025-09-22T10:23:25.579892808Z 
2025-09-22T10:23:25.579896616Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-09-22T10:23:25.579900524Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-09-22T10:23:25.579904191Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0016s) ============
2025-09-22T10:23:25.579907898Z 
2025-09-22T10:23:25.579911476Z Migrating to AddOmniauthToUsers (20241015090803)
2025-09-22T10:23:25.579915103Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-09-22T10:23:25.579918790Z -- add_column(:users, :auth_provider, :string)
2025-09-22T10:23:25.579922568Z    -> 0.0008s
2025-09-22T10:23:25.579926175Z -- add_column(:users, :auth_uid, :string)
2025-09-22T10:23:25.579930193Z    -> 0.0007s
2025-09-22T10:23:25.579934181Z == 20241015090803 AddOmniauthToUsers: migrated (0.0016s) ======================
2025-09-22T10:23:25.579937839Z 
2025-09-22T10:23:25.579941456Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-09-22T10:23:25.579945324Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-09-22T10:23:25.579949061Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-09-22T10:23:25.579952699Z    -> 0.0008s
2025-09-22T10:23:25.579956266Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-09-22T10:23:25.579959893Z    -> 0.0007s
2025-09-22T10:23:25.579963490Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0015s) =====
2025-09-22T10:23:25.579967128Z 
2025-09-22T10:23:25.579970605Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-09-22T10:23:25.579974222Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-09-22T10:23:25.579977839Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-09-22T10:23:25.579981446Z    -> 0.0008s
2025-09-22T10:23:25.579985094Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-09-22T10:23:25.579993801Z 
2025-09-22T10:23:25.579997669Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-09-22T10:23:25.580001557Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-09-22T10:23:25.580006286Z -- change_table(:users)
2025-09-22T10:23:25.580009884Z    -> 0.0010s
2025-09-22T10:23:25.580013471Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-09-22T10:23:25.580017098Z 
2025-09-22T10:23:25.580020645Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-09-22T10:23:25.580024213Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-09-22T10:23:25.580028171Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0064s) =================
2025-09-22T10:23:25.580032008Z 
2025-09-22T10:23:25.580035726Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-09-22T10:23:25.580039283Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-09-22T10:23:25.580042890Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-09-22T10:23:25.580046918Z    -> 0.0011s
2025-09-22T10:23:25.580050465Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-09-22T10:23:25.580054564Z    -> 0.0013s
2025-09-22T10:23:25.580058121Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-09-22T10:23:25.580061999Z    -> 0.0004s
2025-09-22T10:23:25.580065716Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-09-22T10:23:25.580069394Z    -> 0.0009s
2025-09-22T10:23:25.580072931Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-09-22T10:23:25.580076839Z    -> 0.0008s
2025-09-22T10:23:25.580080466Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-09-22T10:23:25.580084584Z    -> 0.0007s
2025-09-22T10:23:25.580089494Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-09-22T10:23:25.580093612Z    -> 0.0004s
2025-09-22T10:23:25.580097450Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0059s) ===================
2025-09-22T10:23:25.580101258Z 
2025-09-22T10:23:25.580105246Z Migrating to AddInProgressToProblems (20241105121830)
2025-09-22T10:23:25.580109144Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-09-22T10:23:25.580113082Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-09-22T10:23:25.580117340Z    -> 0.0009s
2025-09-22T10:23:25.580131569Z == 20241105121830 AddInProgressToProblems: migrated (0.0009s) =================
2025-09-22T10:23:25.580135457Z 
2025-09-22T10:23:25.580138944Z Migrating to ClearStuckProblems (20241118155027)
2025-09-22T10:23:25.580142511Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-09-22T10:23:25.580146389Z == 20241118155027 ClearStuckProblems: migrated (0.0278s) ======================
2025-09-22T10:23:25.580150176Z 
2025-09-22T10:23:25.580154034Z Migrating to AddApprovedToUser (20241122121621)
2025-09-22T10:23:25.580157621Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-09-22T10:23:25.580161369Z -- change_table(:users)
2025-09-22T10:23:25.580165166Z    -> 0.0015s
2025-09-22T10:23:25.580168704Z == 20241122121621 AddApprovedToUser: migrated (0.0015s) =======================
2025-09-22T10:23:25.580172882Z 
2025-09-22T10:23:25.580176790Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-09-22T10:23:25.580180397Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-09-22T10:23:25.580184195Z -- create_table(:federails_moderation_reports)
2025-09-22T10:23:25.580187962Z    -> 0.0029s
2025-09-22T10:23:25.580191519Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0030s) ========
2025-09-22T10:23:25.580195127Z 
2025-09-22T10:23:25.580198584Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-09-22T10:23:25.580202241Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-09-22T10:23:25.580206159Z -- create_table(:federails_moderation_domain_blocks)
2025-09-22T10:23:25.580209997Z    -> 0.0004s
2025-09-22T10:23:25.580213524Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-09-22T10:23:25.580217121Z 
2025-09-22T10:23:25.580220869Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-09-22T10:23:25.580224586Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-09-22T10:23:25.580228173Z -- change_column_null(:comments, :commenter_id, true)
2025-09-22T10:23:25.580232031Z    -> 0.0077s
2025-09-22T10:23:25.580235568Z -- change_column_null(:comments, :commenter_type, true)
2025-09-22T10:23:25.580239286Z    -> 0.0073s
2025-09-22T10:23:25.580243053Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-09-22T10:23:25.580246661Z    -> 0.0010s
2025-09-22T10:23:25.580250208Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-09-22T10:23:25.580253825Z    -> 0.0103s
2025-09-22T10:23:26.436419182Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0282s) =======
2025-09-22T10:23:26.436479013Z 
2025-09-22T10:23:26.436488572Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-09-22T10:23:26.436496999Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-09-22T10:23:26.436505145Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-09-22T10:23:26.436513953Z    -> 0.0009s
2025-09-22T10:23:26.436522640Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0010s) =================
2025-09-22T10:23:26.436530927Z 
2025-09-22T10:23:26.436539234Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-09-22T10:23:26.436547250Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-09-22T10:23:26.436555607Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1708s) ==================
2025-09-22T10:23:26.436563603Z 
2025-09-22T10:23:26.436571268Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-09-22T10:23:26.436579986Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-09-22T10:23:26.436587992Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-09-22T10:23:26.436596669Z    -> 0.0019s
2025-09-22T10:23:26.436604535Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0019s) ==========
2025-09-22T10:23:26.436612471Z 
2025-09-22T10:23:26.436620097Z Migrating to AddCreatorToCollections (20250222000000)
2025-09-22T10:23:26.436627962Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-09-22T10:23:26.436635888Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-09-22T10:23:26.436643935Z    -> 0.0235s
2025-09-22T10:23:26.436651740Z == 20250222000000 AddCreatorToCollections: migrated (0.0236s) =================
2025-09-22T10:23:26.436659746Z 
2025-09-22T10:23:26.436667602Z Migrating to AddLocalToActors (20250305171530)
2025-09-22T10:23:26.436675438Z == 20250305171530 AddLocalToActors: migrating =================================
2025-09-22T10:23:26.436683735Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-09-22T10:23:26.436691701Z    -> 0.0010s
2025-09-22T10:23:26.436699436Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-09-22T10:23:26.436707793Z    -> 0.0019s
2025-09-22T10:23:26.436715629Z    -> 0 rows
2025-09-22T10:23:26.436723455Z == 20250305171530 AddLocalToActors: migrated (0.0059s) ========================
2025-09-22T10:23:26.436731611Z 
2025-09-22T10:23:26.436739237Z Migrating to AddActorTypeToActors (20250407160721)
2025-09-22T10:23:26.436747112Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-09-22T10:23:26.436768776Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-09-22T10:23:26.436776942Z    -> 0.0009s
2025-09-22T10:23:26.436784868Z == 20250407160721 AddActorTypeToActors: migrated (0.0010s) ====================
2025-09-22T10:23:26.436792834Z 
2025-09-22T10:23:26.436800520Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-09-22T10:23:26.436808456Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-09-22T10:23:26.436817825Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-09-22T10:23:26.436826121Z    -> 0.0015s
2025-09-22T10:23:26.436833957Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0015s) =================
2025-09-22T10:23:26.436842314Z 
2025-09-22T10:23:26.436850090Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-09-22T10:23:26.436858026Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-09-22T10:23:26.436866012Z -- create_table(:oauth_applications)
2025-09-22T10:23:26.436873868Z    -> 0.0005s
2025-09-22T10:23:26.436881743Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-09-22T10:23:26.436889710Z    -> 0.0002s
2025-09-22T10:23:26.436897535Z -- create_table(:oauth_access_grants)
2025-09-22T10:23:26.436905802Z    -> 0.0006s
2025-09-22T10:23:26.436913878Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-09-22T10:23:26.436922185Z    -> 0.0001s
2025-09-22T10:23:26.436930031Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-09-22T10:23:26.436938207Z    -> 0.0081s
2025-09-22T10:23:26.436946013Z -- create_table(:oauth_access_tokens)
2025-09-22T10:23:26.436953839Z    -> 0.0014s
2025-09-22T10:23:26.436961624Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-09-22T10:23:26.436969550Z    -> 0.0001s
2025-09-22T10:23:26.436977887Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-09-22T10:23:26.436986224Z    -> 0.0001s
2025-09-22T10:23:26.436994030Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-09-22T10:23:26.437002156Z    -> 0.0094s
2025-09-22T10:23:26.437010152Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-09-22T10:23:26.437018339Z    -> 0.0079s
2025-09-22T10:23:26.437027537Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-09-22T10:23:26.437035794Z    -> 0.0132s
2025-09-22T10:23:26.437044922Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0420s) ==================
2025-09-22T10:23:26.437062758Z 
2025-09-22T10:23:26.437070433Z Migrating to AddOwnerToApplication (20250408145956)
2025-09-22T10:23:26.437078430Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-09-22T10:23:26.437086376Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-09-22T10:23:26.437094301Z    -> 0.0011s
2025-09-22T10:23:26.437102057Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-09-22T10:23:26.437110003Z    -> 0.0009s
2025-09-22T10:23:26.437117859Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-09-22T10:23:26.437125805Z    -> 0.0002s
2025-09-22T10:23:26.437133591Z == 20250408145956 AddOwnerToApplication: migrated (0.0072s) ===================
2025-09-22T10:23:26.437141567Z 
2025-09-22T10:23:26.437149212Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-09-22T10:23:26.437157228Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-09-22T10:23:26.437165345Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-09-22T10:23:26.437173281Z    -> 0.0106s
2025-09-22T10:23:26.437181126Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0120s) ============
2025-09-22T10:23:26.437189062Z 
2025-09-22T10:23:26.437196668Z Migrating to AddQuotaToUsers (20250409125753)
2025-09-22T10:23:26.437204974Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-09-22T10:23:26.437213041Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-09-22T10:23:26.437220957Z    -> 0.0010s
2025-09-22T10:23:26.437228732Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-09-22T10:23:26.437236768Z    -> 0.0008s
2025-09-22T10:23:26.437245225Z == 20250409125753 AddQuotaToUsers: migrated (0.0032s) =========================
2025-09-22T10:23:26.437255556Z 
2025-09-22T10:23:26.437263292Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-09-22T10:23:26.437271228Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-09-22T10:23:26.437279484Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-09-22T10:23:26.437287951Z    -> 0.0121s
2025-09-22T10:23:26.437295797Z -- add_index(:model_files, :filename_lower)
2025-09-22T10:23:26.437303813Z    -> 0.0002s
2025-09-22T10:23:26.437311980Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0137s) 
2025-09-22T10:23:26.437320166Z 
2025-09-22T10:23:26.437327782Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-09-22T10:23:26.437335738Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-09-22T10:23:26.437353012Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-09-22T10:23:26.437361199Z    -> 0.0002s
2025-09-22T10:23:26.437369065Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-09-22T10:23:26.437393404Z 
2025-09-22T10:23:26.437401771Z Migrating to AddPreviewToModelFile (20250520111046)
2025-09-22T10:23:26.437409787Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-09-22T10:23:26.437417793Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-09-22T10:23:26.437425829Z    -> 0.0009s
2025-09-22T10:23:26.437433685Z == 20250520111046 AddPreviewToModelFile: migrated (0.0018s) ===================
2025-09-22T10:23:26.437441701Z 
2025-09-22T10:23:26.437449667Z Migrating to CreateAltchaSolutions (20250609210440)
2025-09-22T10:23:26.437457593Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-09-22T10:23:26.437465689Z -- create_table(:altcha_solutions)
2025-09-22T10:23:26.437473565Z    -> 0.0004s
2025-09-22T10:23:26.437481581Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-09-22T10:23:26.437490068Z    -> 0.0002s
2025-09-22T10:23:26.437497884Z == 20250609210440 CreateAltchaSolutions: migrated (0.0016s) ===================
2025-09-22T10:23:26.437505870Z 
2025-09-22T10:23:26.437513566Z Migrating to AddIndexableFields (20250620141805)
2025-09-22T10:23:26.437521442Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-09-22T10:23:26.437529488Z -- change_table(:models)
2025-09-22T10:23:26.437537334Z    -> 0.0024s
2025-09-22T10:23:26.437545149Z -- change_table(:creators)
2025-09-22T10:23:26.437552995Z    -> 0.0017s
2025-09-22T10:23:26.437560871Z -- change_table(:collections)
2025-09-22T10:23:26.437568687Z    -> 0.0018s
2025-09-22T10:23:26.437576482Z == 20250620141805 AddIndexableFields: migrated (0.0059s) ======================
2025-09-22T10:23:26.437584519Z 
2025-09-22T10:23:26.437592845Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-09-22T10:23:26.437602415Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-09-22T10:23:26.437610431Z -- change_column(:models, :indexable, :string)
2025-09-22T10:23:26.437618357Z    -> 0.0264s
2025-09-22T10:23:26.437626172Z -- change_column(:models, :ai_indexable, :string)
2025-09-22T10:23:26.437634058Z    -> 0.0175s
2025-09-22T10:23:26.437641974Z -- change_column(:creators, :indexable, :string)
2025-09-22T10:23:26.437659129Z    -> 0.0088s
2025-09-22T10:23:26.437667085Z -- change_column(:creators, :ai_indexable, :string)
2025-09-22T10:23:26.437675041Z    -> 0.0087s
2025-09-22T10:23:26.437683197Z -- change_column(:collections, :indexable, :string)
2025-09-22T10:23:26.437691534Z    -> 0.0524s
2025-09-22T10:23:26.437699480Z -- change_column(:collections, :ai_indexable, :string)
2025-09-22T10:23:26.437707406Z    -> 0.0194s
2025-09-22T10:23:26.437715332Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1336s) ======
2025-09-22T10:23:26.437723639Z 
2025-09-22T10:23:26.437731414Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-09-22T10:23:26.437739320Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-09-22T10:23:26.437747357Z -- change_table(:models)
2025-09-22T10:23:26.437755122Z    -> 0.0004s
2025-09-22T10:23:26.437762918Z -- change_table(:creators)
2025-09-22T10:23:26.437770804Z    -> 0.0003s
2025-09-22T10:23:26.437778599Z -- change_table(:collections)
2025-09-22T10:23:26.437786365Z    -> 0.0003s
2025-09-22T10:23:26.437794231Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0010s) =================
2025-09-22T10:23:26.437802257Z 
2025-09-22T10:23:26.437809973Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-09-22T10:23:26.437818149Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-09-22T10:23:26.437826396Z -- change_table(:links)
2025-09-22T10:23:26.437834171Z    -> 0.0008s
2025-09-22T10:23:26.437842308Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0008s) =======================
2025-09-22T10:23:26.437850504Z 
2025-09-22T10:23:26.437859743Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-09-22T10:23:26.437867789Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-09-22T10:23:26.437876146Z -- add_column(:links, :synced_at, :datetime)
2025-09-22T10:23:26.437884252Z    -> 0.0011s
2025-09-22T10:23:26.437892479Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0011s) ======================
2025-09-22T10:23:26.437900475Z 
2025-09-22T10:23:26.437908491Z Migrating to CreateFaspClientProviders (20250806142734)
2025-09-22T10:23:26.437916447Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-09-22T10:23:26.437924573Z -- create_table(:fasp_client_providers)
2025-09-22T10:23:26.437932439Z    -> 0.0491s
2025-09-22T10:23:26.437940826Z == 20250806142734 CreateFaspClientProviders: migrated (0.0491s) ===============
2025-09-22T10:23:26.437948862Z 
2025-09-22T10:23:26.437965616Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-09-22T10:23:26.437973652Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-09-22T10:23:26.437981789Z -- create_table(:fasp_client_event_subscriptions)
2025-09-22T10:23:26.437989624Z    -> 0.0130s
2025-09-22T10:23:26.437997781Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0130s) ======
2025-09-22T10:23:26.438006027Z 
2025-09-22T10:23:26.438014785Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-09-22T10:23:26.459955858Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-09-22T10:23:26.459989666Z -- create_table(:fasp_client_backfill_requests)
2025-09-22T10:23:26.460000828Z    -> 0.0054s
2025-09-22T10:23:26.460011510Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0054s) ========
2025-09-22T10:23:26.460022622Z 
2025-09-22T10:23:26.517542840Z s6-rc: info: service init-manyfold-config successfully started
2025-09-22T10:23:26.517943447Z s6-rc: info: service init-config-end: starting
2025-09-22T10:23:26.520637091Z s6-rc: info: service init-config-end successfully started
2025-09-22T10:23:26.521158030Z s6-rc: info: service init-mods: starting
2025-09-22T10:23:26.523047245Z s6-rc: info: service init-mods successfully started
2025-09-22T10:23:26.523213169Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-09-22T10:23:26.531269802Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-09-22T10:23:26.531405926Z s6-rc: info: service init-mods-package-install: starting
2025-09-22T10:23:26.541800508Z [pkg-install-init] **** Installing all mod packages ****
2025-09-22T10:23:26.549163705Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-09-22T10:23:26.610316348Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-09-22T10:23:26.942025660Z (1/1) Installing redis (8.0.3-r0)
2025-09-22T10:23:26.951065714Z Executing redis-8.0.3-r0.pre-install
2025-09-22T10:23:26.992518758Z Executing redis-8.0.3-r0.post-install
2025-09-22T10:23:27.001542148Z Executing busybox-1.37.0-r19.trigger
2025-09-22T10:23:27.015189500Z OK: 427 MiB in 116 packages
2025-09-22T10:23:27.104378619Z s6-rc: info: service init-mods-package-install successfully started
2025-09-22T10:23:27.104639765Z s6-rc: info: service init-mods-end: starting
2025-09-22T10:23:27.106822892Z s6-rc: info: service init-mods-end successfully started
2025-09-22T10:23:27.107083446Z s6-rc: info: service init-custom-files: starting
2025-09-22T10:23:27.113883780Z [custom-init] No custom files found, skipping...
2025-09-22T10:23:27.114506273Z s6-rc: info: service init-custom-files successfully started
2025-09-22T10:23:27.114740535Z s6-rc: info: service init-services: starting
2025-09-22T10:23:27.116927108Z s6-rc: info: service init-services successfully started
2025-09-22T10:23:27.117145769Z s6-rc: info: service svc-mod-universal-redis: starting
2025-09-22T10:23:27.117350922Z s6-rc: info: service svc-manyfold: starting
2025-09-22T10:23:27.117598841Z s6-rc: info: service svc-cron: starting
2025-09-22T10:23:27.120190861Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-09-22T10:23:27.120536286Z s6-rc: info: service svc-cron successfully started
2025-09-22T10:23:27.136299729Z 281:C 22 Sep 2025 10:23:27.136 # 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-22T10:23:27.136367215Z 281:C 22 Sep 2025 10:23:27.136 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-09-22T10:23:27.136397686Z 281:C 22 Sep 2025 10:23:27.136 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=281, just started
2025-09-22T10:23:27.136409009Z 281:C 22 Sep 2025 10:23:27.136 # 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-22T10:23:27.137402379Z 281:M 22 Sep 2025 10:23:27.137 * monotonic clock: POSIX clock_gettime
2025-09-22T10:23:27.138148071Z 281:M 22 Sep 2025 10:23:27.138 * Running mode=standalone, port=6379.
2025-09-22T10:23:27.138661244Z 281:M 22 Sep 2025 10:23:27.138 * Server initialized
2025-09-22T10:23:27.138700483Z 281:M 22 Sep 2025 10:23:27.138 * Ready to accept connections tcp
2025-09-22T10:23:27.295910887Z 10:23:27 rails.1              | started with pid 301
2025-09-22T10:23:27.295968273Z 10:23:27 default_worker.1     | started with pid 302
2025-09-22T10:23:27.296081922Z 10:23:27 performance_worker.1 | started with pid 303
2025-09-22T10:23:28.575460502Z 10:23:28 rails.1              | `/root` is not writable.
2025-09-22T10:23:28.575517677Z 10:23:28 rails.1              | Bundler will use `/tmp/bundler20250922-301-xe9hy6301' as your home directory temporarily.
2025-09-22T10:23:29.058732204Z 10:23:29 default_worker.1     | `/root` is not writable.
2025-09-22T10:23:29.058776604Z 10:23:29 default_worker.1     | Bundler will use `/tmp/bundler20250922-302-dtzxgs302' as your home directory temporarily.
2025-09-22T10:23:29.080502413Z 10:23:29 performance_worker.1 | `/root` is not writable.
2025-09-22T10:23:29.080548837Z 10:23:29 performance_worker.1 | Bundler will use `/tmp/bundler20250922-303-46hkvz303' as your home directory temporarily.
2025-09-22T10:23:29.620396245Z 10:23:29 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-22T10:23:29.620436676Z 10:23:29 rails.1              | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T10:23:29.620469703Z 10:23:29 rails.1              | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T10:23:29.928162843Z 10:23:29 rails.1              | => Booting Puma
2025-09-22T10:23:29.928198164Z 10:23:29 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-09-22T10:23:29.928229948Z 10:23:29 rails.1              | => Run `bin/rails server --help` for more startup options
2025-09-22T10:23:30.068718670Z 10:23:30 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-22T10:23:30.068751065Z 10:23:30 default_worker.1     | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T10:23:30.068781126Z 10:23:30 default_worker.1     | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T10:23:30.108797196Z 10:23:30 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-22T10:23:30.108812918Z 10:23:30 performance_worker.1 | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-09-22T10:23:30.108959232Z 10:23:30 performance_worker.1 | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-09-22T10:23:30.544646664Z 10:23:30 default_worker.1     | Server: eb72cd62e4a0, Context: rails, Role: web, data: {cpu: {one_min: 5.01, five_min: 3.2, fifteen_min: 2.39}, memory: 0.187420672e9, disk: {available: 834821685248, total: 938656133120, used: 103834447872}}
2025-09-22T10:23:30.577322554Z 10:23:30 performance_worker.1 | Server: eb72cd62e4a0, Context: rails, Role: web, data: {cpu: {one_min: 5.01, five_min: 3.2, fifteen_min: 2.39}, memory: 0.177917952e9, disk: {available: 834815873024, total: 938656133120, used: 103840260096}}
2025-09-22T10:23:32.497828268Z 10:23:32 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:32.499113316Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.498Z pid=302 tid=23y: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T10:23:32.502983509Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.502Z pid=302 tid=23y: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-22T10:23:32.504524071Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.504Z pid=302 tid=23y: Cron Jobs - added job with name clear-downloads in the namespace default
2025-09-22T10:23:32.512976993Z 10:23:32 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:32.514072068Z 10:23:32 performance_worker.1 | INFO  2025-09-22T10:23:32.513Z pid=303 tid=23z: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T10:23:32.557371901Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.556Z pid=302 tid=23y: Booted Rails 8.0.2.1 application in production environment
2025-09-22T10:23:32.557461942Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.557Z pid=302 tid=23y: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-22T10:23:32.557626704Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.557Z pid=302 tid=23y: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-22T10:23:32.557739181Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.557Z pid=302 tid=23y: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-22T10:23:32.560064052Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.559Z pid=302 tid=23y: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-09-22T10:23:32.572250221Z 10:23:32 performance_worker.1 | INFO  2025-09-22T10:23:32.571Z pid=303 tid=23z: Booted Rails 8.0.2.1 application in production environment
2025-09-22T10:23:32.572337747Z 10:23:32 performance_worker.1 | INFO  2025-09-22T10:23:32.571Z pid=303 tid=23z: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-22T10:23:32.572512109Z 10:23:32 performance_worker.1 | INFO  2025-09-22T10:23:32.571Z pid=303 tid=23z: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-22T10:23:32.572610376Z 10:23:32 performance_worker.1 | INFO  2025-09-22T10:23:32.571Z pid=303 tid=23z: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-22T10:23:32.575626800Z 10:23:32 performance_worker.1 | INFO  2025-09-22T10:23:32.575Z pid=303 tid=23z: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-09-22T10:23:32.671088001Z 10:23:32 rails.1              | Server: eb72cd62e4a0, Context: rails, Role: web, data: {cpu: {one_min: 5.01, five_min: 3.2, fifteen_min: 2.39}, memory: 0.185954304e9, disk: {available: 834853388288, total: 938656133120, used: 103802744832}}
2025-09-22T10:23:32.671177892Z 10:23:32 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:32.671222461Z 10:23:32 rails.1              | INFO  2025-09-22T10:23:32.496Z pid=301 tid=2cd: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-22T10:23:32.671284657Z 10:23:32 rails.1              | INFO  2025-09-22T10:23:32.502Z pid=301 tid=2cd: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-22T10:23:32.671330639Z 10:23:32 rails.1              | INFO  2025-09-22T10:23:32.504Z pid=301 tid=2cd: Cron Jobs - added job with name clear-downloads in the namespace default
2025-09-22T10:23:32.671401472Z 10:23:32 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 3b9e7e58-b931-40fe-b2b3-c75ad374f167) to Sidekiq(upgrade)
2025-09-22T10:23:32.671449519Z 10:23:32 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 2bbdec4a-e164-42e4-8776-cf01bd1077ff) to Sidekiq(upgrade)
2025-09-22T10:23:32.671509850Z 10:23:32 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: eda2ea74-206a-4562-abbe-86e8244ecfbd) to Sidekiq(upgrade)
2025-09-22T10:23:32.671521173Z 10:23:32 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 103f78f2-8aad-4b0b-8db0-b499128ae6b9) to Sidekiq(upgrade)
2025-09-22T10:23:32.671569771Z 10:23:32 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: c315b088-8ce2-4136-8707-175f94146ca9) to Sidekiq(upgrade)
2025-09-22T10:23:32.671616916Z 10:23:32 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: 79647d69-bb1c-4860-a4fd-13160c9198a5) to Sidekiq(upgrade)
2025-09-22T10:23:32.671660363Z 10:23:32 rails.1              | [301] Puma starting in cluster mode...
2025-09-22T10:23:32.671707047Z 10:23:32 rails.1              | [301] * Puma version: 7.0.3 ("Romantic Warrior")
2025-09-22T10:23:32.671754372Z 10:23:32 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-22T10:23:32.671799503Z 10:23:32 rails.1              | [301] *  Min threads: 4
2025-09-22T10:23:32.671864975Z 10:23:32 rails.1              | [301] *  Max threads: 16
2025-09-22T10:23:32.671919906Z 10:23:32 rails.1              | [301] *  Environment: production
2025-09-22T10:23:32.671994155Z 10:23:32 rails.1              | [301] *   Master PID: 301
2025-09-22T10:23:32.672042693Z 10:23:32 rails.1              | [301] *      Workers: 4
2025-09-22T10:23:32.672109478Z 10:23:32 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-09-22T10:23:32.672151943Z 10:23:32 rails.1              | [301] * Preloading application
2025-09-22T10:23:32.672210932Z 10:23:32 rails.1              | [301] * Listening on http://[::]:3214
2025-09-22T10:23:32.672256113Z 10:23:32 rails.1              | [301] Use Ctrl-C to stop
2025-09-22T10:23:32.696492187Z 10:23:32 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-09-22T10:23:32.696517187Z 10:23:32 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.02s, phase: 0
2025-09-22T10:23:32.696552989Z 10:23:32 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-09-22T10:23:32.697980163Z 10:23:32 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-09-22T10:23:32.820481263Z 10:23:32 default_worker.1     | Server: eb72cd62e4a0, Context: sidekiq, Role: background, data: {cpu: {one_min: 5.01, five_min: 3.2, fifteen_min: 2.39}, memory: 0.231415808e9, disk: {available: 834775760896, total: 938656133120, used: 103880372224}}
2025-09-22T10:23:32.821136623Z 10:23:32 performance_worker.1 | Server: eb72cd62e4a0, Context: sidekiq, Role: background, data: {cpu: {one_min: 5.01, five_min: 3.2, fifteen_min: 2.39}, memory: 0.221732864e9, disk: {available: 834775760896, total: 938656133120, used: 103880372224}}
2025-09-22T10:23:32.893198263Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.892Z pid=302 tid=hcm jid=9b930eb8b69e0f247933af92 class=Upgrade::FixNilFileSizeValues: start
2025-09-22T10:23:32.910405453Z 10:23:32 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3b9e7e58-b931-40fe-b2b3-c75ad374f167] Performing Upgrade::FixNilFileSizeValues (Job ID: 3b9e7e58-b931-40fe-b2b3-c75ad374f167) from Sidekiq(upgrade) enqueued at 2025-09-22T10:23:32.515617971Z
2025-09-22T10:23:32.911055893Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.892Z pid=302 tid=h0u jid=3f86868b1cb2d7c83b2fba52 class=Upgrade::BackfillDataPackages: start
2025-09-22T10:23:32.915097481Z 10:23:32 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [2bbdec4a-e164-42e4-8776-cf01bd1077ff] Performing Upgrade::BackfillDataPackages (Job ID: 2bbdec4a-e164-42e4-8776-cf01bd1077ff) from Sidekiq(upgrade) enqueued at 2025-09-22T10:23:32.516975845Z
2025-09-22T10:23:32.935053747Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.893Z pid=302 tid=h0m jid=a8f6ef0c39348f7368e51efb class=Upgrade::DisambiguateUsernamesJob: start
2025-09-22T10:23:32.935622653Z 10:23:32 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [eda2ea74-206a-4562-abbe-86e8244ecfbd] Performing Upgrade::DisambiguateUsernamesJob (Job ID: eda2ea74-206a-4562-abbe-86e8244ecfbd) from Sidekiq(upgrade) enqueued at 2025-09-22T10:23:32.517685194Z
2025-09-22T10:23:32.936783320Z 10:23:32 default_worker.1     | INFO  2025-09-22T10:23:32.910Z pid=302 tid=h06 jid=aa1cc56f36903528de0ca6b6 class=Upgrade::UpdateActorsJob: start
2025-09-22T10:23:32.940327246Z 10:23:32 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [103f78f2-8aad-4b0b-8db0-b499128ae6b9] Performing Upgrade::UpdateActorsJob (Job ID: 103f78f2-8aad-4b0b-8db0-b499128ae6b9) from Sidekiq(upgrade) enqueued at 2025-09-22T10:23:32.518308228Z
2025-09-22T10:23:32.949731293Z 10:23:32 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [eda2ea74-206a-4562-abbe-86e8244ecfbd] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:32.955702969Z 10:23:32 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [2bbdec4a-e164-42e4-8776-cf01bd1077ff] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:32.983255651Z 10:23:32 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [103f78f2-8aad-4b0b-8db0-b499128ae6b9] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:33.156360201Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-09-22T10:23:33.157878318Z s6-rc: info: service svc-manyfold successfully started
2025-09-22T10:23:33.158118291Z s6-rc: info: service legacy-services: starting
2025-09-22T10:23:33.170036321Z s6-rc: info: service legacy-services successfully started
2025-09-22T10:23:33.170241093Z s6-rc: info: service ci-service-check: starting
2025-09-22T10:23:33.173573694Z [ls.io-init] done.
2025-09-22T10:23:33.174387994Z s6-rc: info: service ci-service-check successfully started
2025-09-22T10:23:33.224832443Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3b9e7e58-b931-40fe-b2b3-c75ad374f167] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:33.275704554Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3b9e7e58-b931-40fe-b2b3-c75ad374f167] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-22T10:23:33.284292858Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3b9e7e58-b931-40fe-b2b3-c75ad374f167] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.043
2025-09-22T10:23:33.304802338Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [2bbdec4a-e164-42e4-8776-cf01bd1077ff] Performed Upgrade::BackfillDataPackages (Job ID: 2bbdec4a-e164-42e4-8776-cf01bd1077ff) from Sidekiq(upgrade) in 392.16ms
2025-09-22T10:23:33.307680534Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [103f78f2-8aad-4b0b-8db0-b499128ae6b9] Performed Upgrade::UpdateActorsJob (Job ID: 103f78f2-8aad-4b0b-8db0-b499128ae6b9) from Sidekiq(upgrade) in 365.15ms
2025-09-22T10:23:33.308361665Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.307Z pid=302 tid=h0u jid=3f86868b1cb2d7c83b2fba52 class=Upgrade::BackfillDataPackages elapsed=0.415: done
2025-09-22T10:23:33.317239202Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [eda2ea74-206a-4562-abbe-86e8244ecfbd] Performed Upgrade::DisambiguateUsernamesJob (Job ID: eda2ea74-206a-4562-abbe-86e8244ecfbd) from Sidekiq(upgrade) in 370.22ms
2025-09-22T10:23:33.317596292Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.316Z pid=302 tid=h06 jid=aa1cc56f36903528de0ca6b6 class=Upgrade::UpdateActorsJob elapsed=0.406: done
2025-09-22T10:23:33.318397655Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.318Z pid=302 tid=h0m jid=a8f6ef0c39348f7368e51efb class=Upgrade::DisambiguateUsernamesJob elapsed=0.425: done
2025-09-22T10:23:33.318680044Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [3b9e7e58-b931-40fe-b2b3-c75ad374f167] Performed Upgrade::FixNilFileSizeValues (Job ID: 3b9e7e58-b931-40fe-b2b3-c75ad374f167) from Sidekiq(upgrade) in 407.06ms
2025-09-22T10:23:33.318797480Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.317Z pid=302 tid=h0u jid=b5aa0d73b903d7a0aebde50d class=Upgrade::FixParentCollections: start
2025-09-22T10:23:33.319469023Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [c315b088-8ce2-4136-8707-175f94146ca9] Performing Upgrade::FixParentCollections (Job ID: c315b088-8ce2-4136-8707-175f94146ca9) from Sidekiq(upgrade) enqueued at 2025-09-22T10:23:32.518921664Z
2025-09-22T10:23:33.320139683Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.318Z pid=302 tid=h06 jid=c3c728b4669628c56d1f0360 class=Upgrade::PruneOrphanedProblems: start
2025-09-22T10:23:33.325409154Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79647d69-bb1c-4860-a4fd-13160c9198a5] Performing Upgrade::PruneOrphanedProblems (Job ID: 79647d69-bb1c-4860-a4fd-13160c9198a5) from Sidekiq(upgrade) enqueued at 2025-09-22T10:23:32.519927890Z
2025-09-22T10:23:33.325977208Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.319Z pid=302 tid=hcm jid=9b930eb8b69e0f247933af92 class=Upgrade::FixNilFileSizeValues elapsed=0.427: done
2025-09-22T10:23:33.328101876Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [c315b088-8ce2-4136-8707-175f94146ca9] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:33.441114790Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79647d69-bb1c-4860-a4fd-13160c9198a5] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-22T10:23:33.674471880Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79647d69-bb1c-4860-a4fd-13160c9198a5] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-22T10:23:33.682087436Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79647d69-bb1c-4860-a4fd-13160c9198a5] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.113
2025-09-22T10:23:33.682126053Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [c315b088-8ce2-4136-8707-175f94146ca9] Performed Upgrade::FixParentCollections (Job ID: c315b088-8ce2-4136-8707-175f94146ca9) from Sidekiq(upgrade) in 359.06ms
2025-09-22T10:23:33.698026702Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.697Z pid=302 tid=h0u jid=b5aa0d73b903d7a0aebde50d class=Upgrade::FixParentCollections elapsed=0.38: done
2025-09-22T10:23:33.701086795Z 10:23:33 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [79647d69-bb1c-4860-a4fd-13160c9198a5] Performed Upgrade::PruneOrphanedProblems (Job ID: 79647d69-bb1c-4860-a4fd-13160c9198a5) from Sidekiq(upgrade) in 380.15ms
2025-09-22T10:23:33.720266156Z 10:23:33 default_worker.1     | INFO  2025-09-22T10:23:33.719Z pid=302 tid=h06 jid=c3c728b4669628c56d1f0360 class=Upgrade::PruneOrphanedProblems elapsed=0.402: done
2025-09-22T10:24:00.485751118Z 10:24:00 rails.1              | [97da09a9-2309-4f6c-9bf5-e4b7cbe6713e] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1391,"duration":22.91,"view":0.0,"db":3.22,"@timestamp":"2025-09-22T10:24:00.484Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-22T10:24:01.514678551Z 10:24:01 rails.1              | [b69460e8-ad1b-4e49-b1d7-a752c9699fa0] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":93586,"duration":1010.22,"view":0.0,"db":26.1,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-22T10:24:01.514Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-22T10:24:01.602891525Z 10:24:01 rails.1              | [1438d455-6d56-401b-a730-6dc630a51f9d] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1071,"duration":54.95,"view":0.0,"db":3.48,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-22T10:24:01.580Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-22T10:24:02.394636154Z 10:24:02 rails.1              | [65800a54-5595-418f-8b02-d50267f25df9] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24003,"duration":764.89,"view":624.99,"db":74.9,"@timestamp":"2025-09-22T10:24:02.394Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-09-22T10:24:02.470925187Z 10:24:02 rails.1              | [6401ee2b-c89b-4054-ac5a-673f1636f3eb] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1178,"duration":31.45,"view":0.0,"db":4.59,"@timestamp":"2025-09-22T10:24:02.469Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-22T10:24:02.717393218Z 10:24:02 rails.1              | [5090342f-efcf-4244-ac4b-f0d958c8a453] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14500,"duration":214.37,"view":0.0,"db":2.08,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-22T10:24:02.716Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-22T10:24:02.862127768Z 10:24:02 rails.1              | [b37263e6-b737-48cf-9f96-d105e8182251] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1099,"duration":38.91,"view":0.0,"db":2.9,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-22T10:24:02.824Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-22T10:24:03.283194186Z 10:24:03 rails.1              | [0fe0b7aa-fe58-4ec2-9abe-e15de68544aa] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24217,"duration":394.38,"view":195.23,"db":1.4,"@timestamp":"2025-09-22T10:24:03.278Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}