2025-07-30T09:58:23.759014069Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-07-30T09:58:23.759038438Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-07-30T09:58:23.808516729Z [mod-init] Running Docker Modification Logic
2025-07-30T09:58:24.030589570Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-07-30T09:58:25.010148482Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-07-30T09:58:25.439243897Z [mod-init] Installing linuxserver/mods:universal-redis
2025-07-30T09:58:25.465084521Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-07-30T09:58:25.466126599Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-07-30T09:58:25.488654793Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-07-30T09:58:25.491826960Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-07-30T09:58:25.492176384Z s6-rc: info: service fix-attrs: starting
2025-07-30T09:58:25.492427570Z s6-rc: info: service init-migrations: starting
2025-07-30T09:58:25.492681070Z s6-rc: info: service init-envfile: starting
2025-07-30T09:58:25.499701075Z [migrations] started
2025-07-30T09:58:25.499751166Z [migrations] no migrations found
2025-07-30T09:58:25.500167414Z s6-rc: info: service fix-attrs successfully started
2025-07-30T09:58:25.500371125Z s6-rc: info: service legacy-cont-init: starting
2025-07-30T09:58:25.500559123Z s6-rc: info: service init-migrations successfully started
2025-07-30T09:58:25.500781301Z s6-rc: info: service init-adduser: starting
2025-07-30T09:58:25.500976784Z s6-rc: info: service init-envfile successfully started
2025-07-30T09:58:25.506325665Z s6-rc: info: service legacy-cont-init successfully started
2025-07-30T09:58:25.525964730Z usermod: no changes
2025-07-30T09:58:25.534388623Z ───────────────────────────────────────
2025-07-30T09:58:25.534417822Z 
2025-07-30T09:58:25.534426449Z       ██╗     ███████╗██╗ ██████╗
2025-07-30T09:58:25.534435427Z       ██║     ██╔════╝██║██╔═══██╗
2025-07-30T09:58:25.534444055Z       ██║     ███████╗██║██║   ██║
2025-07-30T09:58:25.534452522Z       ██║     ╚════██║██║██║   ██║
2025-07-30T09:58:25.534461039Z       ███████╗███████║██║╚██████╔╝
2025-07-30T09:58:25.534469426Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-07-30T09:58:25.534477753Z 
2025-07-30T09:58:25.534485638Z    Brought to you by linuxserver.io
2025-07-30T09:58:25.534514026Z ───────────────────────────────────────
2025-07-30T09:58:25.535045005Z 
2025-07-30T09:58:25.535078222Z To support LSIO projects visit:
2025-07-30T09:58:25.535087330Z https://www.linuxserver.io/donate/
2025-07-30T09:58:25.535095607Z 
2025-07-30T09:58:25.535104966Z ───────────────────────────────────────
2025-07-30T09:58:25.535116729Z GID/UID
2025-07-30T09:58:25.535125878Z ───────────────────────────────────────
2025-07-30T09:58:25.542049159Z 
2025-07-30T09:58:25.542070381Z User UID:    911
2025-07-30T09:58:25.542078999Z User GID:    911
2025-07-30T09:58:25.542087275Z ───────────────────────────────────────
2025-07-30T09:58:25.543831548Z Linuxserver.io version: v0.120.0-ls95
2025-07-30T09:58:25.544223196Z Build-date: 2025-07-30T09:47:00+00:00
2025-07-30T09:58:25.544255031Z ───────────────────────────────────────
2025-07-30T09:58:25.544266383Z     
2025-07-30T09:58:25.565422804Z s6-rc: info: service init-adduser successfully started
2025-07-30T09:58:25.565569019Z s6-rc: info: service init-device-perms: starting
2025-07-30T09:58:25.570853440Z s6-rc: info: service init-device-perms successfully started
2025-07-30T09:58:25.571003863Z s6-rc: info: service init-os-end: starting
2025-07-30T09:58:25.572653845Z s6-rc: info: service init-os-end successfully started
2025-07-30T09:58:25.572840240Z s6-rc: info: service init-manyfold-config: starting
2025-07-30T09:58:25.573050634Z s6-rc: info: service init-config: starting
2025-07-30T09:58:25.574818023Z s6-rc: info: service init-config successfully started
2025-07-30T09:58:25.574932874Z s6-rc: info: service init-crontab-config: starting
2025-07-30T09:58:25.585907923Z s6-rc: info: service init-crontab-config successfully started
2025-07-30T09:58:25.607617198Z **** Running Manyfold database init. ****
2025-07-30T09:58:27.865863042Z `/root` is not writable.
2025-07-30T09:58:27.866062143Z Bundler will use `/tmp/bundler20250730-173-ltk21d173' as your home directory temporarily.
2025-07-30T09:58:31.069113328Z /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-07-30T09:58:31.069158920Z You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-07-30T09:58:31.069168599Z Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-07-30T09:58:35.313048440Z Server: 0cb4bc9de9aa, Context: rails, Role: web, data: {cpu: {one_min: 1.84, five_min: 3.76, fifteen_min: 3.6}, memory: 0.204214272e9, disk: {available: 858181197824, total: 938656133120, used: 80474935296}}
2025-07-30T09:58:35.313103351Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-07-30T09:58:35.313114283Z INFO  2025-07-30T09:58:32.550Z pid=173 tid=285: Sidekiq 8.0.6 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-07-30T09:58:35.313124062Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-07-30T09:58:35.313132840Z Migrating to CreateLibraries (20210130201037)
2025-07-30T09:58:35.313140967Z == 20210130201037 CreateLibraries: migrating ==================================
2025-07-30T09:58:35.313149584Z -- create_table(:libraries)
2025-07-30T09:58:35.313157901Z    -> 0.0026s
2025-07-30T09:58:35.313166558Z == 20210130201037 CreateLibraries: migrated (0.0027s) =========================
2025-07-30T09:58:35.313174504Z 
2025-07-30T09:58:35.313182701Z Migrating to CreateModels (20210130203243)
2025-07-30T09:58:35.313190566Z == 20210130203243 CreateModels: migrating =====================================
2025-07-30T09:58:35.313198512Z -- create_table(:models)
2025-07-30T09:58:35.313206288Z    -> 0.0008s
2025-07-30T09:58:35.313214074Z == 20210130203243 CreateModels: migrated (0.0009s) ============================
2025-07-30T09:58:35.313222280Z 
2025-07-30T09:58:35.313230306Z Migrating to CreateParts (20210205230918)
2025-07-30T09:58:35.313238202Z == 20210205230918 CreateParts: migrating ======================================
2025-07-30T09:58:35.313246289Z -- create_table(:parts)
2025-07-30T09:58:35.313254074Z    -> 0.0033s
2025-07-30T09:58:35.313261870Z == 20210205230918 CreateParts: migrated (0.0033s) =============================
2025-07-30T09:58:35.313270377Z 
2025-07-30T09:58:35.313278463Z Migrating to AddFieldsToParts (20210210153744)
2025-07-30T09:58:35.313286329Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-07-30T09:58:35.313294245Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-07-30T09:58:35.313302442Z    -> 0.0022s
2025-07-30T09:58:35.313310478Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-07-30T09:58:35.313318434Z    -> 0.0003s
2025-07-30T09:58:35.313326220Z == 20210210153744 AddFieldsToParts: migrated (0.0026s) ========================
2025-07-30T09:58:35.313334176Z 
2025-07-30T09:58:35.313341761Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-07-30T09:58:35.313349627Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-07-30T09:58:35.313387032Z -- create_table(:tags, {id: :integer})
2025-07-30T09:58:35.313395319Z    -> 0.0070s
2025-07-30T09:58:35.313403365Z -- create_table(:taggings, {id: :integer})
2025-07-30T09:58:35.313411331Z    -> 0.0017s
2025-07-30T09:58:35.313419397Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-07-30T09:58:35.313427824Z    -> 0.0039s
2025-07-30T09:58:35.313437774Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-07-30T09:58:35.313446412Z    -> 0.0020s
2025-07-30T09:58:35.313454187Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0148s) ===============
2025-07-30T09:58:35.313462344Z 
2025-07-30T09:58:35.313470270Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-07-30T09:58:35.313478386Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-07-30T09:58:35.313486482Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-07-30T09:58:35.313494488Z    -> 0.0004s
2025-07-30T09:58:35.313502204Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-07-30T09:58:35.313510721Z    -> 0.0016s
2025-07-30T09:58:35.313518447Z -- remove_foreign_key(:taggings, :tags)
2025-07-30T09:58:35.313526272Z    -> 0.1917s
2025-07-30T09:58:35.313534289Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-07-30T09:58:35.313542285Z    -> 0.0169s
2025-07-30T09:58:35.313550281Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-07-30T09:58:35.313559269Z    -> 0.0002s
2025-07-30T09:58:35.313568237Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-07-30T09:58:35.313577105Z    -> 0.0048s
2025-07-30T09:58:35.313586634Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-07-30T09:58:35.313594730Z    -> 0.0743s
2025-07-30T09:58:35.313603037Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3230s) =================
2025-07-30T09:58:35.313611053Z 
2025-07-30T09:58:35.313619019Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-07-30T09:58:35.313627005Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-07-30T09:58:35.313635262Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-07-30T09:58:35.313643579Z    -> 0.0340s
2025-07-30T09:58:35.313651565Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1081s) ===========
2025-07-30T09:58:35.313659601Z 
2025-07-30T09:58:35.313667487Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-07-30T09:58:35.313685453Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-07-30T09:58:35.313693689Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-07-30T09:58:35.313702668Z    -> 0.0002s
2025-07-30T09:58:35.313710614Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-07-30T09:58:35.313718499Z 
2025-07-30T09:58:35.313726125Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-07-30T09:58:35.313734211Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-07-30T09:58:35.313742498Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0013s) ==============
2025-07-30T09:58:35.313750444Z 
2025-07-30T09:58:35.313758380Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-07-30T09:58:35.313766676Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-07-30T09:58:35.313775765Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-07-30T09:58:35.313784252Z    -> 0.0072s
2025-07-30T09:58:35.313792258Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-07-30T09:58:35.313800244Z    -> 0.0002s
2025-07-30T09:58:35.313808230Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-07-30T09:58:35.313816387Z    -> 0.0056s
2025-07-30T09:58:35.313824122Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-07-30T09:58:35.313832198Z    -> 0.0011s
2025-07-30T09:58:35.313840184Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-07-30T09:58:35.313848291Z    -> 0.0004s
2025-07-30T09:58:35.313856016Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-07-30T09:58:35.313864073Z    -> 0.0001s
2025-07-30T09:58:35.313871868Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-07-30T09:58:35.313879894Z    -> 0.0037s
2025-07-30T09:58:35.313887590Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-07-30T09:58:35.313895626Z    -> 0.0001s
2025-07-30T09:58:35.313903352Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-07-30T09:58:35.313911338Z    -> 0.0005s
2025-07-30T09:58:35.313919073Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-07-30T09:58:35.313927019Z    -> 0.0001s
2025-07-30T09:58:35.313935216Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-07-30T09:58:35.313943442Z    -> 0.0008s
2025-07-30T09:58:35.313960497Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-07-30T09:58:35.313969004Z    -> 0.0001s
2025-07-30T09:58:35.313976940Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-07-30T09:58:35.313985517Z    -> 0.0014s
2025-07-30T09:58:35.313993293Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-07-30T09:58:35.314001479Z    -> 0.0002s
2025-07-30T09:58:35.314009325Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0218s) =============
2025-07-30T09:58:35.314017271Z 
2025-07-30T09:58:35.314024876Z Migrating to AddPreviewPartToModel (20210220204055)
2025-07-30T09:58:35.314032712Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-07-30T09:58:35.314040638Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-07-30T09:58:35.314048694Z    -> 0.2321s
2025-07-30T09:58:35.314056420Z == 20210220204055 AddPreviewPartToModel: migrated (0.2322s) ===================
2025-07-30T09:58:35.314064366Z 
2025-07-30T09:58:35.314072091Z Migrating to CreateCreators (20210225232756)
2025-07-30T09:58:35.314080088Z == 20210225232756 CreateCreators: migrating ===================================
2025-07-30T09:58:35.314088264Z -- create_table(:creators)
2025-07-30T09:58:35.314096050Z    -> 0.0133s
2025-07-30T09:58:35.314103815Z == 20210225232756 CreateCreators: migrated (0.0133s) ==========================
2025-07-30T09:58:35.314111751Z 
2025-07-30T09:58:35.314120529Z Migrating to AddCreatorToModels (20210225232841)
2025-07-30T09:58:35.314128445Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-07-30T09:58:35.314136511Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-07-30T09:58:35.314144708Z    -> 0.0478s
2025-07-30T09:58:35.314152513Z == 20210225232841 AddCreatorToModels: migrated (0.0479s) ======================
2025-07-30T09:58:35.314160790Z 
2025-07-30T09:58:35.314169037Z Migrating to CreateLinks (20210301230017)
2025-07-30T09:58:35.314177103Z == 20210301230017 CreateLinks: migrating ======================================
2025-07-30T09:58:35.314185249Z -- create_table(:links)
2025-07-30T09:58:35.314193215Z    -> 0.0007s
2025-07-30T09:58:35.314201081Z == 20210301230017 CreateLinks: migrated (0.0008s) =============================
2025-07-30T09:58:35.314209328Z 
2025-07-30T09:58:35.314217184Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-07-30T09:58:35.314225560Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-07-30T09:58:35.314243126Z -- remove_column(:creators, :thingiverse_user, :string)
2025-07-30T09:58:35.314251393Z    -> 0.0672s
2025-07-30T09:58:35.314259148Z -- remove_column(:creators, :cults3d_user, :string)
2025-07-30T09:58:35.314267264Z    -> 0.0039s
2025-07-30T09:58:35.314275220Z -- remove_column(:creators, :mmf_user, :string)
2025-07-30T09:58:35.314283116Z    -> 0.0134s
2025-07-30T09:58:35.314291123Z -- remove_column(:creators, :cgtrader_user, :string)
2025-07-30T09:58:35.314299279Z    -> 0.0033s
2025-07-30T09:58:35.314307365Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0899s) ==============
2025-07-30T09:58:35.314315552Z 
2025-07-30T09:58:35.314323397Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-07-30T09:58:35.314331604Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-07-30T09:58:35.314340171Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-07-30T09:58:35.314348518Z    -> 0.0567s
2025-07-30T09:58:35.314356514Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0567s) ==
2025-07-30T09:58:35.314364761Z 
2025-07-30T09:58:35.314372406Z Migrating to AddYUpToParts (20210318202638)
2025-07-30T09:58:35.314380422Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-07-30T09:58:35.314388559Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-07-30T09:58:35.314396485Z    -> 0.0152s
2025-07-30T09:58:35.314404611Z == 20210318202638 AddYUpToParts: migrated (0.0153s) ===========================
2025-07-30T09:58:35.314412557Z 
2025-07-30T09:58:35.314420132Z Migrating to CreateImages (20210321164508)
2025-07-30T09:58:35.314427958Z == 20210321164508 CreateImages: migrating =====================================
2025-07-30T09:58:35.314438189Z -- create_table(:images)
2025-07-30T09:58:35.314446255Z    -> 0.0167s
2025-07-30T09:58:35.314454241Z == 20210321164508 CreateImages: migrated (0.0168s) ============================
2025-07-30T09:58:35.314462728Z 
2025-07-30T09:58:35.314470634Z Migrating to CreateDelayedJobs (20210330215825)
2025-07-30T09:58:35.314478510Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-07-30T09:58:35.314486636Z -- create_table(:delayed_jobs)
2025-07-30T09:58:35.314494773Z    -> 0.0086s
2025-07-30T09:58:35.964877839Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-07-30T09:58:35.964916827Z    -> 0.0001s
2025-07-30T09:58:35.964926567Z == 20210330215825 CreateDelayedJobs: migrated (0.0088s) =======================
2025-07-30T09:58:35.964935435Z 
2025-07-30T09:58:35.964959503Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-07-30T09:58:35.964967689Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-07-30T09:58:35.964975756Z -- rename_table(:parts, :model_files)
2025-07-30T09:58:35.964983672Z    -> 0.0016s
2025-07-30T09:58:35.964991588Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-07-30T09:58:35.964999874Z    -> 0.0322s
2025-07-30T09:58:35.965008001Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0339s) =================
2025-07-30T09:58:35.965016127Z 
2025-07-30T09:58:35.965024945Z Migrating to RemoveImagesTable (20220106220519)
2025-07-30T09:58:35.965034895Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-07-30T09:58:35.965045206Z -- drop_table(:images)
2025-07-30T09:58:35.965054805Z    -> 0.0003s
2025-07-30T09:58:35.965064715Z == 20220106220519 RemoveImagesTable: migrated (0.0003s) =======================
2025-07-30T09:58:35.965073853Z 
2025-07-30T09:58:35.965081669Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-07-30T09:58:35.965089665Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-07-30T09:58:35.965097641Z -- table_exists?(:active_storage_blobs)
2025-07-30T09:58:35.965106659Z    -> 0.0001s
2025-07-30T09:58:35.965116730Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-07-30T09:58:35.965126960Z 
2025-07-30T09:58:35.965136900Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-07-30T09:58:35.965147241Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-07-30T09:58:35.965157331Z -- table_exists?(:active_storage_blobs)
2025-07-30T09:58:35.965167061Z    -> 0.0001s
2025-07-30T09:58:35.965177211Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-07-30T09:58:35.965187422Z 
2025-07-30T09:58:35.965196260Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-07-30T09:58:35.965204486Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-07-30T09:58:35.965212623Z -- table_exists?(:active_storage_blobs)
2025-07-30T09:58:35.965220649Z    -> 0.0001s
2025-07-30T09:58:35.965228635Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-07-30T09:58:35.965238755Z 
2025-07-30T09:58:35.965248605Z Migrating to DeviseCreateUsers (20220614210023)
2025-07-30T09:58:35.965258395Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-07-30T09:58:35.965268595Z -- create_table(:users)
2025-07-30T09:58:35.965278505Z    -> 0.0011s
2025-07-30T09:58:35.965300991Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-07-30T09:58:35.965309508Z    -> 0.0015s
2025-07-30T09:58:35.965317343Z == 20220614210023 DeviseCreateUsers: migrated (0.0027s) =======================
2025-07-30T09:58:35.965325630Z 
2025-07-30T09:58:35.965333245Z Migrating to AddUsernameToUsers (20220614211256)
2025-07-30T09:58:35.965341763Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-07-30T09:58:35.965352464Z -- add_column(:users, :username, :string, {null: false})
2025-07-30T09:58:35.965363306Z    -> 0.0210s
2025-07-30T09:58:35.965373907Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-07-30T09:58:35.965384158Z    -> 0.0001s
2025-07-30T09:58:35.965393767Z == 20220614211256 AddUsernameToUsers: migrated (0.0212s) ======================
2025-07-30T09:58:35.965402074Z 
2025-07-30T09:58:35.965409740Z Migrating to AddAdminToUsers (20220614213902)
2025-07-30T09:58:35.965417585Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-07-30T09:58:35.965425601Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-07-30T09:58:35.965433527Z    -> 0.0005s
2025-07-30T09:58:35.965441303Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-07-30T09:58:35.965449229Z 
2025-07-30T09:58:35.965456824Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-07-30T09:58:35.965464720Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-07-30T09:58:35.965472786Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-07-30T09:58:35.965482005Z    -> 0.0010s
2025-07-30T09:58:35.965489801Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0011s) =============
2025-07-30T09:58:35.965497677Z 
2025-07-30T09:58:35.965505262Z Migrating to CreateSettings (20220619174307)
2025-07-30T09:58:35.965513048Z == 20220619174307 CreateSettings: migrating ===================================
2025-07-30T09:58:35.965520933Z -- create_table(:settings)
2025-07-30T09:58:35.965528729Z    -> 0.0025s
2025-07-30T09:58:35.965539150Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-07-30T09:58:35.965549822Z    -> 0.0002s
2025-07-30T09:58:35.965559651Z == 20220619174307 CreateSettings: migrated (0.0028s) ==========================
2025-07-30T09:58:35.965569852Z 
2025-07-30T09:58:35.965579952Z Migrating to AddScaleFactorToModels (20220626152444)
2025-07-30T09:58:35.965592487Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-07-30T09:58:35.965622478Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-07-30T09:58:35.965634292Z    -> 0.0098s
2025-07-30T09:58:35.965644733Z == 20220626152444 AddScaleFactorToModels: migrated (0.0120s) ==================
2025-07-30T09:58:35.965654583Z 
2025-07-30T09:58:35.965664973Z Migrating to AddDigestToModelFiles (20220702202932)
2025-07-30T09:58:35.965675244Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-07-30T09:58:35.965685264Z -- add_column(:model_files, :digest, :string)
2025-07-30T09:58:35.965695234Z    -> 0.0023s
2025-07-30T09:58:35.965705445Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-07-30T09:58:35.965715555Z    -> 0.0001s
2025-07-30T09:58:35.965726397Z == 20220702202932 AddDigestToModelFiles: migrated (0.0044s) ===================
2025-07-30T09:58:35.965735395Z 
2025-07-30T09:58:35.965743932Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-07-30T09:58:35.965752800Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-07-30T09:58:35.965763492Z -- 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-07-30T09:58:35.965778282Z    -> 0.0008s
2025-07-30T09:58:35.965788382Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0011s) ==============
2025-07-30T09:58:35.965798693Z 
2025-07-30T09:58:35.965808372Z Migrating to CreateProblems (20221210001132)
2025-07-30T09:58:35.965818563Z == 20221210001132 CreateProblems: migrating ===================================
2025-07-30T09:58:35.965829124Z -- create_table(:problems)
2025-07-30T09:58:35.965839174Z    -> 0.0008s
2025-07-30T09:58:35.965848954Z == 20221210001132 CreateProblems: migrated (0.0011s) ==========================
2025-07-30T09:58:35.965858784Z 
2025-07-30T09:58:35.965866529Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-07-30T09:58:35.965874485Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-07-30T09:58:35.965882461Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0168s) ========
2025-07-30T09:58:35.965890748Z 
2025-07-30T09:58:35.965898604Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-07-30T09:58:35.965906530Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-07-30T09:58:35.965914506Z -- create_table(:favorites, {force: true})
2025-07-30T09:58:35.965922332Z    -> 0.0044s
2025-07-30T09:58:35.965943234Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-07-30T09:58:35.965952492Z    -> 0.0001s
2025-07-30T09:58:35.965960278Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-07-30T09:58:35.965968905Z    -> 0.0001s
2025-07-30T09:58:35.965976962Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-07-30T09:58:35.965985890Z    -> 0.0001s
2025-07-30T09:58:35.965993635Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0052s) ================
2025-07-30T09:58:35.966001731Z 
2025-07-30T09:58:35.966009327Z Migrating to MovePrintedToFavorites (20221220223040)
2025-07-30T09:58:35.966017583Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-07-30T09:58:35.966025580Z == 20221220223040 MovePrintedToFavorites: migrated (0.0305s) ==================
2025-07-30T09:58:35.966033816Z 
2025-07-30T09:58:35.966041431Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-07-30T09:58:35.966049317Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-07-30T09:58:35.966057293Z -- remove_column(:model_files, :printed, :boolean)
2025-07-30T09:58:35.966065179Z    -> 0.0246s
2025-07-30T09:58:35.966073245Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0250s) ===============
2025-07-30T09:58:35.966081302Z 
2025-07-30T09:58:35.966089147Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-07-30T09:58:35.966098226Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-07-30T09:58:35.966106643Z -- add_column(:models, :notes, :text)
2025-07-30T09:58:35.966116833Z    -> 0.0006s
2025-07-30T09:58:35.966126924Z -- add_column(:models, :excerpt, :text)
2025-07-30T09:58:35.966136904Z    -> 0.0022s
2025-07-30T09:58:35.966146162Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0028s) =================
2025-07-30T09:58:35.966154720Z 
2025-07-30T09:58:35.966162615Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-07-30T09:58:35.966170591Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-07-30T09:58:35.966178537Z -- add_column(:creators, :notes, :text)
2025-07-30T09:58:35.966186574Z    -> 0.0005s
2025-07-30T09:58:35.966194540Z -- add_column(:creators, :excerpt, :text)
2025-07-30T09:58:35.966202416Z    -> 0.0004s
2025-07-30T09:58:35.966210141Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-07-30T09:58:35.966218157Z 
2025-07-30T09:58:35.966225753Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-07-30T09:58:35.966243739Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-07-30T09:58:35.966251745Z -- add_column(:model_files, :notes, :text)
2025-07-30T09:58:35.966259611Z    -> 0.0005s
2025-07-30T09:58:35.966267426Z -- add_column(:model_files, :excerpt, :text)
2025-07-30T09:58:35.966275262Z    -> 0.0004s
2025-07-30T09:58:35.966283058Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0010s) =============
2025-07-30T09:58:35.966291124Z 
2025-07-30T09:58:35.966300042Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-07-30T09:58:35.966309822Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-07-30T09:58:35.966319962Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0310s) =================
2025-07-30T09:58:35.966329291Z 
2025-07-30T09:58:35.966336936Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-07-30T09:58:35.966345073Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-07-30T09:58:35.966353009Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-07-30T09:58:35.966361285Z    -> 0.0444s
2025-07-30T09:58:35.966369292Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0445s) =============
2025-07-30T09:58:35.966377218Z 
2025-07-30T09:58:35.966384853Z Migrating to RenameExcerptToCaption (20230222155910)
2025-07-30T09:58:35.966392709Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-07-30T09:58:35.966400685Z -- rename_column(:creators, :excerpt, :caption)
2025-07-30T09:58:35.966408531Z    -> 0.0239s
2025-07-30T09:58:35.966416296Z -- rename_column(:models, :excerpt, :caption)
2025-07-30T09:58:35.966425064Z    -> 0.0122s
2025-07-30T09:58:35.966435124Z -- rename_column(:model_files, :excerpt, :caption)
2025-07-30T09:58:35.966444844Z    -> 0.0209s
2025-07-30T09:58:35.966454593Z == 20230222155910 RenameExcerptToCaption: migrated (0.0596s) ==================
2025-07-30T09:58:35.966464573Z 
2025-07-30T09:58:35.966473862Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-07-30T09:58:35.966483862Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-07-30T09:58:35.966493401Z -- add_column(:libraries, :notes, :string)
2025-07-30T09:58:35.966505295Z    -> 0.0022s
2025-07-30T09:58:35.966519294Z -- add_column(:libraries, :caption, :string)
2025-07-30T09:58:36.491192637Z    -> 0.0005s
2025-07-30T09:58:36.491228409Z -- add_column(:libraries, :name, :string)
2025-07-30T09:58:36.491237638Z    -> 0.0005s
2025-07-30T09:58:36.491269893Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0122s) ============
2025-07-30T09:58:36.491278490Z 
2025-07-30T09:58:36.491286847Z Migrating to AddTagregexToLibrary (20230305180823)
2025-07-30T09:58:36.491295034Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-07-30T09:58:36.491303180Z -- add_column(:libraries, :tag_regex, :text)
2025-07-30T09:58:36.491311296Z    -> 0.0020s
2025-07-30T09:58:36.491319493Z == 20230305180823 AddTagregexToLibrary: migrated (0.0037s) ====================
2025-07-30T09:58:36.491327619Z 
2025-07-30T09:58:36.491335485Z Migrating to AddIconToLibrary (20230307215826)
2025-07-30T09:58:36.491343541Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-07-30T09:58:36.491351738Z -- add_column(:libraries, :icon, :text)
2025-07-30T09:58:36.491359994Z    -> 0.0073s
2025-07-30T09:58:36.491367930Z == 20230307215826 AddIconToLibrary: migrated (0.0089s) ========================
2025-07-30T09:58:36.491376147Z 
2025-07-30T09:58:36.491383742Z Migrating to CreateCollection (20230308004237)
2025-07-30T09:58:36.491391628Z == 20230308004237 CreateCollection: migrating =================================
2025-07-30T09:58:36.491399574Z -- create_table(:collections)
2025-07-30T09:58:36.491407470Z    -> 0.0028s
2025-07-30T09:58:36.491415446Z == 20230308004237 CreateCollection: migrated (0.0070s) ========================
2025-07-30T09:58:36.491423392Z 
2025-07-30T09:58:36.491431088Z Migrating to AddCollectionToModels (20230308005021)
2025-07-30T09:58:36.491441098Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-07-30T09:58:36.491451338Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-07-30T09:58:36.491461188Z    -> 0.0363s
2025-07-30T09:58:36.491470858Z == 20230308005021 AddCollectionToModels: migrated (0.0405s) ===================
2025-07-30T09:58:36.491480958Z 
2025-07-30T09:58:36.491490818Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-07-30T09:58:36.491500517Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-07-30T09:58:36.491510588Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0016s) =============
2025-07-30T09:58:36.491520738Z 
2025-07-30T09:58:36.491529766Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-07-30T09:58:36.491539806Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-07-30T09:58:36.491549957Z -- rename_column(:collections, :excerpt, :caption)
2025-07-30T09:58:36.491560017Z    -> 0.0042s
2025-07-30T09:58:36.491569536Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0042s) ========
2025-07-30T09:58:36.491593044Z 
2025-07-30T09:58:36.491603384Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-07-30T09:58:36.491613565Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-07-30T09:58:36.491623956Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-07-30T09:58:36.491633545Z 
2025-07-30T09:58:36.491643154Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-07-30T09:58:36.491655038Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-07-30T09:58:36.491665670Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-07-30T09:58:36.491677193Z    -> 0.0016s
2025-07-30T09:58:36.491686732Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0017s) ===============
2025-07-30T09:58:36.491696562Z 
2025-07-30T09:58:36.491706171Z Migrating to AddCollectionToCollections (20230324000000)
2025-07-30T09:58:36.491716242Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-07-30T09:58:36.491725731Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-07-30T09:58:36.491735350Z    -> 0.0071s
2025-07-30T09:58:36.491745651Z == 20230324000000 AddCollectionToCollections: migrated (0.0092s) ==============
2025-07-30T09:58:36.491755320Z 
2025-07-30T09:58:36.491765040Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-07-30T09:58:36.491774659Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-07-30T09:58:36.491784689Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0356s) =========
2025-07-30T09:58:36.491795090Z 
2025-07-30T09:58:36.491805081Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-07-30T09:58:36.491815361Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-07-30T09:58:36.491825852Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0065s) 
2025-07-30T09:58:36.491836223Z 
2025-07-30T09:58:36.491862155Z Migrating to AddSlugs (20230615135601)
2025-07-30T09:58:36.491874310Z == 20230615135601 AddSlugs: migrating =========================================
2025-07-30T09:58:36.491883709Z -- add_column(:models, :slug, :string)
2025-07-30T09:58:36.491892607Z    -> 0.0015s
2025-07-30T09:58:36.491901535Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-07-30T09:58:36.491912387Z    -> 0.0013s
2025-07-30T09:58:36.491922697Z -- add_column(:collections, :slug, :string)
2025-07-30T09:58:36.491932477Z    -> 0.0010s
2025-07-30T09:58:36.491956716Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-07-30T09:58:36.491967828Z    -> 0.0001s
2025-07-30T09:58:36.491977909Z -- add_column(:creators, :slug, :string)
2025-07-30T09:58:36.491988079Z    -> 0.0005s
2025-07-30T09:58:36.492000534Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-07-30T09:58:36.492010925Z    -> 0.0001s
2025-07-30T09:58:36.492020955Z == 20230615135601 AddSlugs: migrated (0.0052s) ================================
2025-07-30T09:58:36.492032889Z 
2025-07-30T09:58:36.492042729Z Migrating to GenerateSlugs (20230617222353)
2025-07-30T09:58:36.492052639Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-07-30T09:58:36.492062619Z == 20230617222353 GenerateSlugs: migrated (0.0538s) ===========================
2025-07-30T09:58:36.492072539Z 
2025-07-30T09:58:36.492082179Z Migrating to MakeNamesUnique (20230628194944)
2025-07-30T09:58:36.492091678Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-07-30T09:58:36.492103191Z == 20230628194944 MakeNamesUnique: migrated (0.0029s) =========================
2025-07-30T09:58:36.492113391Z 
2025-07-30T09:58:36.492123121Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-07-30T09:58:36.492133271Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-07-30T09:58:36.492143191Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-07-30T09:58:36.492153672Z    -> 0.0021s
2025-07-30T09:58:36.492163612Z -- remove_index(:creators, :slug)
2025-07-30T09:58:36.492174214Z    -> 0.0004s
2025-07-30T09:58:36.492183683Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-07-30T09:58:36.492191859Z    -> 0.0001s
2025-07-30T09:58:36.492199685Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-07-30T09:58:36.492207791Z    -> 0.0001s
2025-07-30T09:58:36.492215637Z -- remove_index(:collections, :slug)
2025-07-30T09:58:36.492223433Z    -> 0.0221s
2025-07-30T09:58:36.492231209Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-07-30T09:58:36.492239335Z    -> 0.0006s
2025-07-30T09:58:36.492247171Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0260s) ======
2025-07-30T09:58:36.492255357Z 
2025-07-30T09:58:36.492262932Z Migrating to AddSizeToModelFiles (20230707082403)
2025-07-30T09:58:36.492270758Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-07-30T09:58:36.492278694Z -- add_column(:model_files, :size, :integer)
2025-07-30T09:58:36.492298985Z    -> 0.0012s
2025-07-30T09:58:36.492306851Z == 20230707082403 AddSizeToModelFiles: migrated (0.0015s) =====================
2025-07-30T09:58:36.492316621Z 
2025-07-30T09:58:36.492326100Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-07-30T09:58:36.492335990Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-07-30T09:58:36.492346190Z -- change_column(:model_files, :size, :bigint)
2025-07-30T09:58:36.492355609Z    -> 0.0078s
2025-07-30T09:58:36.492363505Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0081s) ==================
2025-07-30T09:58:36.492371742Z 
2025-07-30T09:58:36.492379597Z Migrating to AddNoteToProblems (20230711111009)
2025-07-30T09:58:36.492387694Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-07-30T09:58:36.492398576Z -- add_column(:problems, :note, :string, {default: nil})
2025-07-30T09:58:36.492408616Z    -> 0.0012s
2025-07-30T09:58:36.492420520Z == 20230711111009 AddNoteToProblems: migrated (0.0022s) =======================
2025-07-30T09:58:36.492430851Z 
2025-07-30T09:58:36.492440590Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-07-30T09:58:36.492451111Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-07-30T09:58:36.492463506Z -- 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}})
2025-07-30T09:58:36.492481212Z    -> 0.0036s
2025-07-30T09:58:36.492491934Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0037s) ================
2025-07-30T09:58:36.492503828Z 
2025-07-30T09:58:36.492516383Z Migrating to AddLicenseToModel (20240127143358)
2025-07-30T09:58:36.492529690Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-07-30T09:58:36.492542155Z -- add_column(:models, :license, :string)
2025-07-30T09:58:36.492553057Z    -> 0.0006s
2025-07-30T09:58:36.492563207Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-07-30T09:58:36.492573448Z 
2025-07-30T09:58:36.492583899Z Migrating to AddIgnoredToProblems (20240131134832)
2025-07-30T09:58:36.492593638Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-07-30T09:58:36.492603689Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-07-30T09:58:36.492613849Z    -> 0.0006s
2025-07-30T09:58:36.492623248Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-07-30T09:58:36.492646906Z 
2025-07-30T09:58:36.492655473Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-07-30T09:58:36.492664671Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-07-30T09:58:36.492674972Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-07-30T09:58:36.492685183Z    -> 0.0100s
2025-07-30T09:58:36.492695223Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0101s) ======
2025-07-30T09:58:36.492705193Z 
2025-07-30T09:58:36.492714762Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-07-30T09:58:36.492725113Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-07-30T09:58:36.492735404Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-07-30T09:58:36.492745935Z    -> 0.0006s
2025-07-30T09:58:36.492755775Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-07-30T09:58:36.492765184Z 
2025-07-30T09:58:36.492773140Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-07-30T09:58:36.492781056Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-07-30T09:58:36.492788962Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-07-30T09:58:36.492797028Z    -> 0.0002s
2025-07-30T09:58:36.492804784Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-07-30T09:58:36.492813010Z    -> 0.0001s
2025-07-30T09:58:36.492820876Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-07-30T09:58:36.492829103Z    -> 0.0001s
2025-07-30T09:58:36.492836918Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-07-30T09:58:36.492845245Z    -> 0.0040s
2025-07-30T09:58:36.890245058Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0047s) =================
2025-07-30T09:58:36.890287344Z 
2025-07-30T09:58:36.890296422Z Migrating to CreateFlipperTables (20240306095646)
2025-07-30T09:58:36.890305300Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-07-30T09:58:36.890313626Z -- create_table(:flipper_features)
2025-07-30T09:58:36.890321693Z    -> 0.0027s
2025-07-30T09:58:36.890330190Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-07-30T09:58:36.890339308Z    -> 0.0043s
2025-07-30T09:58:36.890347354Z -- create_table(:flipper_gates)
2025-07-30T09:58:36.890384579Z    -> 0.0003s
2025-07-30T09:58:36.890392996Z -- 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-07-30T09:58:36.890402195Z    -> 0.0001s
2025-07-30T09:58:36.890410221Z == 20240306095646 CreateFlipperTables: migrated (0.0075s) =====================
2025-07-30T09:58:36.890418678Z 
2025-07-30T09:58:36.890426664Z Migrating to RolifyCreateRoles (20240319155251)
2025-07-30T09:58:36.890434820Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-07-30T09:58:36.890443137Z -- create_table(:roles)
2025-07-30T09:58:36.890451083Z    -> 0.0346s
2025-07-30T09:58:36.890458979Z -- create_table(:users_roles, {id: false})
2025-07-30T09:58:36.890467136Z    -> 0.0005s
2025-07-30T09:58:36.890475092Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-07-30T09:58:36.890483208Z    -> 0.0046s
2025-07-30T09:58:36.890491114Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-07-30T09:58:36.890499681Z    -> 0.0002s
2025-07-30T09:58:36.890507527Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-07-30T09:58:36.890515974Z    -> 0.0001s
2025-07-30T09:58:36.890524661Z == 20240319155251 RolifyCreateRoles: migrated (0.0550s) =======================
2025-07-30T09:58:36.890532968Z 
2025-07-30T09:58:36.890540954Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-07-30T09:58:36.890549381Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-07-30T09:58:36.890557618Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0084s) ==================
2025-07-30T09:58:36.890565904Z 
2025-07-30T09:58:36.890573680Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-07-30T09:58:36.890581937Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-07-30T09:58:36.890589903Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-07-30T09:58:36.890598470Z    -> 0.0237s
2025-07-30T09:58:36.890606887Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0255s) ====================
2025-07-30T09:58:36.890615244Z 
2025-07-30T09:58:36.890623250Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-07-30T09:58:36.890631406Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-07-30T09:58:36.890639583Z -- add_column(:users, :reset_password_token, :string)
2025-07-30T09:58:36.890647499Z    -> 0.0011s
2025-07-30T09:58:36.890655385Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-07-30T09:58:36.890677549Z    -> 0.0002s
2025-07-30T09:58:36.890685856Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0031s) ============
2025-07-30T09:58:36.890694363Z 
2025-07-30T09:58:36.890702309Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-07-30T09:58:36.890710345Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-07-30T09:58:36.890719213Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0184s) ==============
2025-07-30T09:58:36.890727239Z 
2025-07-30T09:58:36.890734945Z Migrating to AddRememberableToUsers (20240410221112)
2025-07-30T09:58:36.890743031Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-07-30T09:58:36.890751167Z -- add_column(:users, :remember_created_at, :datetime)
2025-07-30T09:58:36.890759154Z    -> 0.0029s
2025-07-30T09:58:36.890768382Z == 20240410221112 AddRememberableToUsers: migrated (0.0040s) ==================
2025-07-30T09:58:36.890778523Z 
2025-07-30T09:58:36.890788202Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-07-30T09:58:36.890797962Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-07-30T09:58:36.890806489Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-07-30T09:58:36.890814876Z    -> 0.0006s
2025-07-30T09:58:36.890823022Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0017s) ===========
2025-07-30T09:58:36.890831880Z 
2025-07-30T09:58:36.890840066Z Migrating to DropDelayedJobs (20240418112821)
2025-07-30T09:58:36.890848503Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-07-30T09:58:36.890856790Z -- drop_table(:delayed_jobs)
2025-07-30T09:58:36.890864716Z    -> 0.0017s
2025-07-30T09:58:36.890872883Z == 20240418112821 DropDelayedJobs: migrated (0.0107s) =========================
2025-07-30T09:58:36.890881009Z 
2025-07-30T09:58:36.890888684Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-07-30T09:58:36.890896660Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-07-30T09:58:36.890904717Z -- add_column(:users, :interface_language, :string)
2025-07-30T09:58:36.890912733Z    -> 0.0007s
2025-07-30T09:58:36.890920749Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0037s) =============
2025-07-30T09:58:36.890928905Z 
2025-07-30T09:58:36.890936611Z Migrating to AddLockableToUsers (20240610120318)
2025-07-30T09:58:36.890944607Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-07-30T09:58:36.890952653Z -- change_table(:users)
2025-07-30T09:58:36.890960549Z    -> 0.0018s
2025-07-30T09:58:36.890978786Z == 20240610120318 AddLockableToUsers: migrated (0.0021s) ======================
2025-07-30T09:58:36.890986842Z 
2025-07-30T09:58:36.890994628Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-07-30T09:58:36.891002854Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-07-30T09:58:36.891010941Z -- add_column(:model_files, :attachment_data, :json)
2025-07-30T09:58:36.891019428Z    -> 0.0006s
2025-07-30T09:58:36.891027294Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0009s) ===========
2025-07-30T09:58:36.891035580Z 
2025-07-30T09:58:36.891043546Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-07-30T09:58:36.891052063Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-07-30T09:58:36.891060430Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0062s) ==================
2025-07-30T09:58:36.891068677Z 
2025-07-30T09:58:36.891076362Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-07-30T09:58:36.891084489Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-07-30T09:58:36.891092475Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-07-30T09:58:36.891100691Z    -> 0.0006s
2025-07-30T09:58:36.891108587Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0023s) ============
2025-07-30T09:58:36.891116613Z 
2025-07-30T09:58:36.891124299Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-07-30T09:58:36.891132455Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-07-30T09:58:36.891140441Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-07-30T09:58:36.891148528Z    -> 0.0006s
2025-07-30T09:58:36.891156414Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-07-30T09:58:36.891164460Z    -> 0.0006s
2025-07-30T09:58:36.891172346Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-07-30T09:58:36.891180352Z    -> 0.0006s
2025-07-30T09:58:36.891188258Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-07-30T09:58:36.891196344Z    -> 0.0044s
2025-07-30T09:58:36.891204390Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-07-30T09:58:36.891212887Z    -> 0.0006s
2025-07-30T09:58:36.891221054Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0078s) ====================
2025-07-30T09:58:36.891229721Z 
2025-07-30T09:58:36.891237667Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-07-30T09:58:36.891246034Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-07-30T09:58:36.891263790Z -- remove_index(:libraries, :path)
2025-07-30T09:58:36.891271906Z    -> 0.0009s
2025-07-30T09:58:36.891280253Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0016s) ================
2025-07-30T09:58:36.891288429Z 
2025-07-30T09:58:36.891296375Z Migrating to CreateFederailsActors (20240727113215)
2025-07-30T09:58:36.891304622Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-07-30T09:58:36.891312869Z -- create_table(:federails_actors)
2025-07-30T09:58:36.891321265Z    -> 0.0008s
2025-07-30T09:58:36.891329442Z -- foreign_key_exists?(:federails_actors, :users)
2025-07-30T09:58:36.891338190Z    -> 0.0017s
2025-07-30T09:58:36.891346536Z -- remove_foreign_key(:federails_actors, :users)
2025-07-30T09:58:36.891355164Z    -> 0.0105s
2025-07-30T09:58:36.891363651Z -- remove_index(:federails_actors, :user_id)
2025-07-30T09:58:36.891371877Z    -> 0.0004s
2025-07-30T09:58:36.891380034Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-07-30T09:58:36.891388511Z    -> 0.0001s
2025-07-30T09:58:36.891396577Z -- add_foreign_key(:federails_actors, :users)
2025-07-30T09:58:36.891404513Z    -> 0.0092s
2025-07-30T09:58:36.891412599Z == 20240727113215 CreateFederailsActors: migrated (0.0235s) ===================
2025-07-30T09:58:36.891421147Z 
2025-07-30T09:58:36.891429203Z Migrating to CreateFederailsFollowings (20240727113216)
2025-07-30T09:58:36.891437660Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-07-30T09:58:36.891445987Z -- create_table(:federails_followings)
2025-07-30T09:58:36.891453933Z    -> 0.0009s
2025-07-30T09:58:36.891461788Z == 20240727113216 CreateFederailsFollowings: migrated (0.0009s) ===============
2025-07-30T09:58:36.891471378Z 
2025-07-30T09:58:36.891480877Z Migrating to CreateFederailsActivities (20240727113217)
2025-07-30T09:58:36.891490807Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-07-30T09:58:36.891498973Z -- create_table(:federails_activities)
2025-07-30T09:58:36.891506919Z    -> 0.0077s
2025-07-30T09:58:36.891514785Z == 20240727113217 CreateFederailsActivities: migrated (0.0078s) ===============
2025-07-30T09:58:36.891522801Z 
2025-07-30T09:58:36.891530467Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-07-30T09:58:36.891538413Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-07-30T09:58:36.891546459Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-07-30T09:58:36.891559686Z    -> 0.0077s
2025-07-30T09:58:36.891579876Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-07-30T09:58:36.891588123Z    -> 0.0004s
2025-07-30T09:58:36.891596169Z -- change_table(:federails_actors)
2025-07-30T09:58:36.891604185Z    -> 0.0062s
2025-07-30T09:58:36.891612231Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0143s) =======
2025-07-30T09:58:36.891621500Z 
2025-07-30T09:58:36.891631200Z Migrating to CreateFederailsActors (20240731165647)
2025-07-30T09:58:36.891641350Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-07-30T09:58:36.891649536Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-07-30T09:58:36.891657653Z 
2025-07-30T09:58:36.891665358Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-07-30T09:58:36.891673364Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-07-30T09:58:36.891682333Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-07-30T09:58:36.891690419Z 
2025-07-30T09:58:36.891698144Z Migrating to BackfillActivities (20240805111500)
2025-07-30T09:58:36.891706281Z == 20240805111500 BackfillActivities: migrating ===============================
2025-07-30T09:58:36.891714287Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-07-30T09:58:36.891722393Z 
2025-07-30T09:58:36.891730159Z Migrating to CreateCaberRelations (20240827155630)
2025-07-30T09:58:36.891738135Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-07-30T09:58:36.891746211Z -- create_table(:caber_relations)
2025-07-30T09:58:36.891754217Z    -> 0.0356s
2025-07-30T09:58:36.891762213Z == 20240827155630 CreateCaberRelations: migrated (0.0357s) ====================
2025-07-30T09:58:36.891771011Z 
2025-07-30T09:58:36.891778807Z Migrating to AddDefaultAccessControls (20240830121749)
2025-07-30T09:58:36.891786993Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-07-30T09:58:36.891795100Z == 20240830121749 AddDefaultAccessControls: migrated (0.0211s) ================
2025-07-30T09:58:36.891803196Z 
2025-07-30T09:58:36.891811443Z Migrating to RenameDefaultRoles (20240830151650)
2025-07-30T09:58:37.507193991Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-07-30T09:58:37.507240615Z == 20240830151650 RenameDefaultRoles: migrated (0.0372s) ======================
2025-07-30T09:58:37.507250104Z 
2025-07-30T09:58:37.507258130Z Migrating to AddPublicIDsToModels (20240904151944)
2025-07-30T09:58:37.507266246Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-07-30T09:58:37.507302940Z -- add_column(:models, :public_id, :string)
2025-07-30T09:58:37.507311197Z    -> 0.0009s
2025-07-30T09:58:37.507319774Z -- add_index(:models, :public_id)
2025-07-30T09:58:37.507327680Z    -> 0.0023s
2025-07-30T09:58:37.507336217Z -- add_column(:model_files, :public_id, :string)
2025-07-30T09:58:37.507344654Z    -> 0.0006s
2025-07-30T09:58:37.507352580Z -- add_index(:model_files, :public_id)
2025-07-30T09:58:37.507361067Z    -> 0.0001s
2025-07-30T09:58:37.507369254Z -- add_column(:problems, :public_id, :string)
2025-07-30T09:58:37.507377240Z    -> 0.0007s
2025-07-30T09:58:37.507385146Z -- add_index(:problems, :public_id)
2025-07-30T09:58:37.507393041Z    -> 0.0001s
2025-07-30T09:58:37.507401068Z -- add_column(:creators, :public_id, :string)
2025-07-30T09:58:37.507409134Z    -> 0.0006s
2025-07-30T09:58:37.507417020Z -- add_index(:creators, :public_id)
2025-07-30T09:58:37.507424946Z    -> 0.0002s
2025-07-30T09:58:37.507432852Z -- add_column(:collections, :public_id, :string)
2025-07-30T09:58:37.507440828Z    -> 0.0006s
2025-07-30T09:58:37.507448744Z -- add_index(:collections, :public_id)
2025-07-30T09:58:37.507456640Z    -> 0.0001s
2025-07-30T09:58:37.507464936Z -- add_column(:libraries, :public_id, :string)
2025-07-30T09:58:37.507472882Z    -> 0.0006s
2025-07-30T09:58:37.507480798Z -- add_index(:libraries, :public_id)
2025-07-30T09:58:37.507488734Z    -> 0.0001s
2025-07-30T09:58:37.507496650Z == 20240904151944 AddPublicIDsToModels: migrated (0.0073s) ====================
2025-07-30T09:58:37.507505308Z 
2025-07-30T09:58:37.507513614Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-07-30T09:58:37.507521630Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-07-30T09:58:37.507530408Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:37.507538815Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0328s) ==============
2025-07-30T09:58:37.507547142Z 
2025-07-30T09:58:37.507555148Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-07-30T09:58:37.507563354Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-07-30T09:58:37.507571621Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-07-30T09:58:37.507579667Z 
2025-07-30T09:58:37.507587603Z Migrating to DeduplicateRoles (20240923114515)
2025-07-30T09:58:37.507596140Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-07-30T09:58:37.507604457Z == 20240923114515 DeduplicateRoles: migrated (0.1313s) ========================
2025-07-30T09:58:37.507623135Z 
2025-07-30T09:58:37.507631472Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-07-30T09:58:37.507639708Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-07-30T09:58:37.507648195Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-07-30T09:58:37.507656833Z    -> 0.1505s
2025-07-30T09:58:37.507666983Z -- add_index(:models, :name_lower)
2025-07-30T09:58:37.507675530Z    -> 0.0002s
2025-07-30T09:58:37.507684007Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-07-30T09:58:37.507692434Z    -> 0.0074s
2025-07-30T09:58:37.507700571Z -- add_index(:creators, :name_lower)
2025-07-30T09:58:37.507708817Z    -> 0.0001s
2025-07-30T09:58:37.507716984Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-07-30T09:58:37.507725441Z    -> 0.0100s
2025-07-30T09:58:37.507733918Z -- add_index(:collections, :name_lower)
2025-07-30T09:58:37.507742235Z    -> 0.0001s
2025-07-30T09:58:37.507750531Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1686s) =============
2025-07-30T09:58:37.507759289Z 
2025-07-30T09:58:37.507767065Z Migrating to AddKeypairToActors (20240926162407)
2025-07-30T09:58:37.507775682Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-07-30T09:58:37.507784329Z -- change_table(:federails_actors)
2025-07-30T09:58:37.507792305Z    -> 0.0016s
2025-07-30T09:58:37.507800241Z == 20240926162407 AddKeypairToActors: migrated (0.0016s) ======================
2025-07-30T09:58:37.507808809Z 
2025-07-30T09:58:37.507816915Z Migrating to AddUuids (20241004194445)
2025-07-30T09:58:37.507824861Z == 20241004194445 AddUuids: migrating =========================================
2025-07-30T09:58:37.507833218Z -- change_table(:federails_actors)
2025-07-30T09:58:37.507841454Z    -> 0.0029s
2025-07-30T09:58:37.507863539Z -- change_table(:federails_activities)
2025-07-30T09:58:37.507874270Z    -> 0.0009s
2025-07-30T09:58:37.507882257Z -- change_table(:federails_followings)
2025-07-30T09:58:37.507890333Z    -> 0.0009s
2025-07-30T09:58:37.507898219Z == 20241004194445 AddUuids: migrated (0.0047s) ================================
2025-07-30T09:58:37.507906325Z 
2025-07-30T09:58:37.507914061Z Migrating to CreateComments (20241007182824)
2025-07-30T09:58:37.507921977Z == 20241007182824 CreateComments: migrating ===================================
2025-07-30T09:58:37.507930243Z -- create_table(:comments)
2025-07-30T09:58:37.507947839Z    -> 0.0020s
2025-07-30T09:58:37.507955755Z == 20241007182824 CreateComments: migrated (0.0020s) ==========================
2025-07-30T09:58:37.507963911Z 
2025-07-30T09:58:37.507971606Z Migrating to AddSystemToComments (20241009122540)
2025-07-30T09:58:37.507979583Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-07-30T09:58:37.507987619Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-07-30T09:58:37.507995665Z    -> 0.0008s
2025-07-30T09:58:37.508003521Z == 20241009122540 AddSystemToComments: migrated (0.0009s) =====================
2025-07-30T09:58:37.508011557Z 
2025-07-30T09:58:37.508019272Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-07-30T09:58:37.508027900Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-07-30T09:58:37.508035946Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0015s) ============
2025-07-30T09:58:37.508043992Z 
2025-07-30T09:58:37.508051688Z Migrating to AddOmniauthToUsers (20241015090803)
2025-07-30T09:58:37.508059834Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-07-30T09:58:37.508067870Z -- add_column(:users, :auth_provider, :string)
2025-07-30T09:58:37.508076227Z    -> 0.0008s
2025-07-30T09:58:37.508084143Z -- add_column(:users, :auth_uid, :string)
2025-07-30T09:58:37.508093041Z    -> 0.0007s
2025-07-30T09:58:37.508100967Z == 20241015090803 AddOmniauthToUsers: migrated (0.0016s) ======================
2025-07-30T09:58:37.508109053Z 
2025-07-30T09:58:37.508117019Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-07-30T09:58:37.508125065Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-07-30T09:58:37.508133122Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-07-30T09:58:37.508141198Z    -> 0.0008s
2025-07-30T09:58:37.508149064Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-07-30T09:58:37.508157631Z    -> 0.0007s
2025-07-30T09:58:37.508165507Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0015s) =====
2025-07-30T09:58:37.508174054Z 
2025-07-30T09:58:37.508181950Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-07-30T09:58:37.508189966Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-07-30T09:58:37.508197962Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-07-30T09:58:37.508206279Z    -> 0.0008s
2025-07-30T09:58:37.508214656Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-07-30T09:58:37.508232321Z 
2025-07-30T09:58:37.508240358Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-07-30T09:58:37.508248544Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-07-30T09:58:37.508256851Z -- change_table(:users)
2025-07-30T09:58:37.508265067Z    -> 0.0009s
2025-07-30T09:58:37.508273344Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-07-30T09:58:37.508282122Z 
2025-07-30T09:58:37.508289877Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-07-30T09:58:37.508298274Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-07-30T09:58:37.508306902Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0064s) =================
2025-07-30T09:58:37.508314948Z 
2025-07-30T09:58:37.508322874Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-07-30T09:58:37.508331040Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-07-30T09:58:37.508339117Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-07-30T09:58:37.508347513Z    -> 0.0016s
2025-07-30T09:58:37.508355409Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-07-30T09:58:37.508363896Z    -> 0.0012s
2025-07-30T09:58:37.508371752Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-07-30T09:58:37.508379939Z    -> 0.0004s
2025-07-30T09:58:37.508387845Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-07-30T09:58:37.508396071Z    -> 0.0009s
2025-07-30T09:58:37.508403937Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-07-30T09:58:37.508412194Z    -> 0.0008s
2025-07-30T09:58:37.508420029Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-07-30T09:58:37.508428336Z    -> 0.0007s
2025-07-30T09:58:37.508437344Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-07-30T09:58:37.508445912Z    -> 0.0004s
2025-07-30T09:58:37.508453787Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0062s) ===================
2025-07-30T09:58:37.508462174Z 
2025-07-30T09:58:37.508470431Z Migrating to AddInProgressToProblems (20241105121830)
2025-07-30T09:58:37.508478407Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-07-30T09:58:37.508486664Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-07-30T09:58:37.508495491Z    -> 0.0008s
2025-07-30T09:58:37.508503588Z == 20241105121830 AddInProgressToProblems: migrated (0.0008s) =================
2025-07-30T09:58:37.508523317Z 
2025-07-30T09:58:37.508531233Z Migrating to ClearStuckProblems (20241118155027)
2025-07-30T09:58:37.508539851Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-07-30T09:58:37.508547937Z == 20241118155027 ClearStuckProblems: migrated (0.0239s) ======================
2025-07-30T09:58:37.508556344Z 
2025-07-30T09:58:37.508564400Z Migrating to AddApprovedToUser (20241122121621)
2025-07-30T09:58:37.508573128Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-07-30T09:58:37.508581184Z -- change_table(:users)
2025-07-30T09:58:37.508589330Z    -> 0.0013s
2025-07-30T09:58:37.508597266Z == 20241122121621 AddApprovedToUser: migrated (0.0014s) =======================
2025-07-30T09:58:37.508607046Z 
2025-07-30T09:58:37.508614802Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-07-30T09:58:37.508622848Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-07-30T09:58:37.508630864Z -- create_table(:federails_moderation_reports)
2025-07-30T09:58:37.508638920Z    -> 0.0030s
2025-07-30T09:58:37.508646846Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0030s) ========
2025-07-30T09:58:37.508654912Z 
2025-07-30T09:58:37.508662708Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-07-30T09:58:37.508670734Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-07-30T09:58:37.508678790Z -- create_table(:federails_moderation_domain_blocks)
2025-07-30T09:58:37.508686827Z    -> 0.0004s
2025-07-30T09:58:37.508694763Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-07-30T09:58:37.508703230Z 
2025-07-30T09:58:37.508711556Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-07-30T09:58:37.508719583Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-07-30T09:58:37.508727589Z -- change_column_null(:comments, :commenter_id, true)
2025-07-30T09:58:37.508735675Z    -> 0.0077s
2025-07-30T09:58:37.508743581Z -- change_column_null(:comments, :commenter_type, true)
2025-07-30T09:58:37.508751577Z    -> 0.0074s
2025-07-30T09:58:37.508759453Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-07-30T09:58:37.508767860Z    -> 0.0008s
2025-07-30T09:58:37.508776237Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-07-30T09:58:37.508784604Z    -> 0.0105s
2025-07-30T09:58:38.183884990Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0278s) =======
2025-07-30T09:58:38.183929219Z 
2025-07-30T09:58:38.183969420Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-07-30T09:58:38.183977827Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-07-30T09:58:38.183986284Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-07-30T09:58:38.183994531Z    -> 0.0008s
2025-07-30T09:58:38.184002717Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0009s) =================
2025-07-30T09:58:38.184011215Z 
2025-07-30T09:58:38.184019341Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-07-30T09:58:38.184027457Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-07-30T09:58:38.184035463Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1198s) ==================
2025-07-30T09:58:38.184043710Z 
2025-07-30T09:58:38.184051886Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-07-30T09:58:38.184059832Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-07-30T09:58:38.184067829Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-07-30T09:58:38.184076035Z    -> 0.0021s
2025-07-30T09:58:38.184083851Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0022s) ==========
2025-07-30T09:58:38.184091917Z 
2025-07-30T09:58:38.184099582Z Migrating to AddCreatorToCollections (20250222000000)
2025-07-30T09:58:38.184107468Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-07-30T09:58:38.184115705Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-07-30T09:58:38.184123711Z    -> 0.0227s
2025-07-30T09:58:38.184131467Z == 20250222000000 AddCreatorToCollections: migrated (0.0228s) =================
2025-07-30T09:58:38.184139693Z 
2025-07-30T09:58:38.184147289Z Migrating to AddLocalToActors (20250305171530)
2025-07-30T09:58:38.184155124Z == 20250305171530 AddLocalToActors: migrating =================================
2025-07-30T09:58:38.184163120Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-07-30T09:58:38.184171197Z    -> 0.0009s
2025-07-30T09:58:38.184182610Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-07-30T09:58:38.184191097Z    -> 0.0017s
2025-07-30T09:58:38.184200055Z    -> 0 rows
2025-07-30T09:58:38.184207921Z == 20250305171530 AddLocalToActors: migrated (0.0054s) ========================
2025-07-30T09:58:38.184215947Z 
2025-07-30T09:58:38.184223773Z Migrating to AddActorTypeToActors (20250407160721)
2025-07-30T09:58:38.184232089Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-07-30T09:58:38.184239985Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-07-30T09:58:38.184258322Z    -> 0.0008s
2025-07-30T09:58:38.184266619Z == 20250407160721 AddActorTypeToActors: migrated (0.0008s) ====================
2025-07-30T09:58:38.184274855Z 
2025-07-30T09:58:38.184282461Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-07-30T09:58:38.184290637Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-07-30T09:58:38.184299886Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-07-30T09:58:38.184307972Z    -> 0.0012s
2025-07-30T09:58:38.184315758Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0012s) =================
2025-07-30T09:58:38.184324034Z 
2025-07-30T09:58:38.184331670Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-07-30T09:58:38.184339516Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-07-30T09:58:38.184347642Z -- create_table(:oauth_applications)
2025-07-30T09:58:38.184355418Z    -> 0.0004s
2025-07-30T09:58:38.184363183Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-07-30T09:58:38.184371039Z    -> 0.0002s
2025-07-30T09:58:38.184379045Z -- create_table(:oauth_access_grants)
2025-07-30T09:58:38.184386991Z    -> 0.0006s
2025-07-30T09:58:38.184394787Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-07-30T09:58:38.184402663Z    -> 0.0001s
2025-07-30T09:58:38.184410408Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-07-30T09:58:38.184418404Z    -> 0.0072s
2025-07-30T09:58:38.184428184Z -- create_table(:oauth_access_tokens)
2025-07-30T09:58:38.184438034Z    -> 0.0006s
2025-07-30T09:58:38.184447673Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-07-30T09:58:38.184457593Z    -> 0.0002s
2025-07-30T09:58:38.184465690Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-07-30T09:58:38.184473886Z    -> 0.0001s
2025-07-30T09:58:38.184481622Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-07-30T09:58:38.184490419Z    -> 0.0084s
2025-07-30T09:58:38.184498816Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-07-30T09:58:38.184506943Z    -> 0.0071s
2025-07-30T09:58:38.184515510Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-07-30T09:58:38.184526141Z    -> 0.0089s
2025-07-30T09:58:38.184536222Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0340s) ==================
2025-07-30T09:58:38.184545430Z 
2025-07-30T09:58:38.184563547Z Migrating to AddOwnerToApplication (20250408145956)
2025-07-30T09:58:38.184571753Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-07-30T09:58:38.184579930Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-07-30T09:58:38.184588026Z    -> 0.0010s
2025-07-30T09:58:38.184596623Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-07-30T09:58:38.184605942Z    -> 0.0008s
2025-07-30T09:58:38.184615662Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-07-30T09:58:38.184625622Z    -> 0.0002s
2025-07-30T09:58:38.184634500Z == 20250408145956 AddOwnerToApplication: migrated (0.0064s) ===================
2025-07-30T09:58:38.184642706Z 
2025-07-30T09:58:38.184650301Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-07-30T09:58:38.184658207Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-07-30T09:58:38.184666183Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-07-30T09:58:38.184674851Z    -> 0.0098s
2025-07-30T09:58:38.184682777Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0110s) ============
2025-07-30T09:58:38.184690973Z 
2025-07-30T09:58:38.184699030Z Migrating to AddQuotaToUsers (20250409125753)
2025-07-30T09:58:38.184707757Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-07-30T09:58:38.184715994Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-07-30T09:58:38.184724190Z    -> 0.0009s
2025-07-30T09:58:38.184732046Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-07-30T09:58:38.184740343Z    -> 0.0009s
2025-07-30T09:58:38.184748409Z == 20250409125753 AddQuotaToUsers: migrated (0.0032s) =========================
2025-07-30T09:58:38.184756826Z 
2025-07-30T09:58:38.184764992Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-07-30T09:58:38.184773419Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-07-30T09:58:38.184782017Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-07-30T09:58:38.184790434Z    -> 0.0216s
2025-07-30T09:58:38.184798169Z -- add_index(:model_files, :filename_lower)
2025-07-30T09:58:38.184806456Z    -> 0.0002s
2025-07-30T09:58:38.184814171Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0231s) 
2025-07-30T09:58:38.184822147Z 
2025-07-30T09:58:38.184829783Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-07-30T09:58:38.184837558Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-07-30T09:58:38.184855254Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-07-30T09:58:38.184863290Z    -> 0.0002s
2025-07-30T09:58:38.184871146Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-07-30T09:58:38.184879573Z 
2025-07-30T09:58:38.184887750Z Migrating to AddPreviewToModelFile (20250520111046)
2025-07-30T09:58:38.184896167Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-07-30T09:58:38.184904203Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-07-30T09:58:38.184912539Z    -> 0.0011s
2025-07-30T09:58:38.184920616Z == 20250520111046 AddPreviewToModelFile: migrated (0.0019s) ===================
2025-07-30T09:58:38.184928682Z 
2025-07-30T09:58:38.184936387Z Migrating to CreateAltchaSolutions (20250609210440)
2025-07-30T09:58:38.184944674Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-07-30T09:58:38.184952710Z -- create_table(:altcha_solutions)
2025-07-30T09:58:38.184960626Z    -> 0.0004s
2025-07-30T09:58:38.184968552Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-07-30T09:58:38.184977029Z    -> 0.0002s
2025-07-30T09:58:38.184984825Z == 20250609210440 CreateAltchaSolutions: migrated (0.0016s) ===================
2025-07-30T09:58:38.184992871Z 
2025-07-30T09:58:38.185000567Z Migrating to AddIndexableFields (20250620141805)
2025-07-30T09:58:38.185008803Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-07-30T09:58:38.185016890Z -- change_table(:models)
2025-07-30T09:58:38.185024816Z    -> 0.0028s
2025-07-30T09:58:38.185032661Z -- change_table(:creators)
2025-07-30T09:58:38.185040547Z    -> 0.0017s
2025-07-30T09:58:38.185048634Z -- change_table(:collections)
2025-07-30T09:58:38.185056640Z    -> 0.0024s
2025-07-30T09:58:38.185064816Z == 20250620141805 AddIndexableFields: migrated (0.0070s) ======================
2025-07-30T09:58:38.185073203Z 
2025-07-30T09:58:38.185081520Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-07-30T09:58:38.185089736Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-07-30T09:58:38.185097923Z -- change_column(:models, :indexable, :string)
2025-07-30T09:58:38.185106019Z    -> 0.0251s
2025-07-30T09:58:38.185113875Z -- change_column(:models, :ai_indexable, :string)
2025-07-30T09:58:38.185121831Z    -> 0.0187s
2025-07-30T09:58:38.185129927Z -- change_column(:creators, :indexable, :string)
2025-07-30T09:58:38.185138545Z    -> 0.0095s
2025-07-30T09:58:38.185155649Z -- change_column(:creators, :ai_indexable, :string)
2025-07-30T09:58:38.185163655Z    -> 0.0091s
2025-07-30T09:58:38.185171641Z -- change_column(:collections, :indexable, :string)
2025-07-30T09:58:38.185179928Z    -> 0.0509s
2025-07-30T09:58:38.185187744Z -- change_column(:collections, :ai_indexable, :string)
2025-07-30T09:58:38.185195710Z    -> 0.0146s
2025-07-30T09:58:38.185203636Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1285s) ======
2025-07-30T09:58:38.185212043Z 
2025-07-30T09:58:38.185219798Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-07-30T09:58:38.185229077Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-07-30T09:58:38.185238977Z -- change_table(:models)
2025-07-30T09:58:38.185248787Z    -> 0.0004s
2025-07-30T09:58:38.185257745Z -- change_table(:creators)
2025-07-30T09:58:38.185265600Z    -> 0.0003s
2025-07-30T09:58:38.185273657Z -- change_table(:collections)
2025-07-30T09:58:38.185281893Z    -> 0.0003s
2025-07-30T09:58:38.185289990Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0010s) =================
2025-07-30T09:58:38.185298517Z 
2025-07-30T09:58:38.185306342Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-07-30T09:58:38.185315351Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-07-30T09:58:38.185326212Z -- change_table(:links)
2025-07-30T09:58:38.185336854Z    -> 0.0002s
2025-07-30T09:58:38.185344990Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-07-30T09:58:38.185353578Z 
2025-07-30T09:58:38.185361544Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-07-30T09:58:38.185369770Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-07-30T09:58:38.185377836Z -- add_column(:links, :synced_at, :datetime)
2025-07-30T09:58:38.185385742Z    -> 0.0011s
2025-07-30T09:58:38.185393819Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0012s) ======================
2025-07-30T09:58:38.185403288Z 
2025-07-30T09:58:38.244131314Z s6-rc: info: service init-manyfold-config successfully started
2025-07-30T09:58:38.244478944Z s6-rc: info: service init-config-end: starting
2025-07-30T09:58:38.246558742Z s6-rc: info: service init-config-end successfully started
2025-07-30T09:58:38.246715237Z s6-rc: info: service init-mods: starting
2025-07-30T09:58:38.248586986Z s6-rc: info: service init-mods successfully started
2025-07-30T09:58:38.248812029Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-07-30T09:58:38.256248343Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-07-30T09:58:38.256426823Z s6-rc: info: service init-mods-package-install: starting
2025-07-30T09:58:38.268590616Z [pkg-install-init] **** Installing all mod packages ****
2025-07-30T09:58:38.275875495Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-07-30T09:58:38.339174756Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-07-30T09:58:38.683746282Z (1/1) Installing redis (8.0.3-r0)
2025-07-30T09:58:38.696342486Z Executing redis-8.0.3-r0.pre-install
2025-07-30T09:58:38.736068890Z Executing redis-8.0.3-r0.post-install
2025-07-30T09:58:38.743750137Z Executing busybox-1.37.0-r18.trigger
2025-07-30T09:58:38.758112388Z OK: 421 MiB in 114 packages
2025-07-30T09:58:38.843797795Z s6-rc: info: service init-mods-package-install successfully started
2025-07-30T09:58:38.844070965Z s6-rc: info: service init-mods-end: starting
2025-07-30T09:58:38.845993637Z s6-rc: info: service init-mods-end successfully started
2025-07-30T09:58:38.846228700Z s6-rc: info: service init-custom-files: starting
2025-07-30T09:58:38.852602124Z [custom-init] No custom files found, skipping...
2025-07-30T09:58:38.853286061Z s6-rc: info: service init-custom-files successfully started
2025-07-30T09:58:38.853475563Z s6-rc: info: service init-services: starting
2025-07-30T09:58:38.855392653Z s6-rc: info: service init-services successfully started
2025-07-30T09:58:38.855571002Z s6-rc: info: service svc-mod-universal-redis: starting
2025-07-30T09:58:38.855819262Z s6-rc: info: service svc-manyfold: starting
2025-07-30T09:58:38.855976800Z s6-rc: info: service svc-cron: starting
2025-07-30T09:58:38.858371662Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-07-30T09:58:38.858627687Z s6-rc: info: service svc-cron successfully started
2025-07-30T09:58:38.872032650Z 281:C 30 Jul 2025 09:58:38.871 # 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-07-30T09:58:38.872097480Z 281:C 30 Jul 2025 09:58:38.872 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-07-30T09:58:38.872110436Z 281:C 30 Jul 2025 09:58:38.872 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=281, just started
2025-07-30T09:58:38.872116789Z 281:C 30 Jul 2025 09:58:38.872 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-07-30T09:58:38.873042122Z 281:M 30 Jul 2025 09:58:38.873 * monotonic clock: POSIX clock_gettime
2025-07-30T09:58:38.873704606Z 281:M 30 Jul 2025 09:58:38.873 * Running mode=standalone, port=6379.
2025-07-30T09:58:38.874161867Z 281:M 30 Jul 2025 09:58:38.874 * Server initialized
2025-07-30T09:58:38.874206046Z 281:M 30 Jul 2025 09:58:38.874 * Ready to accept connections tcp
2025-07-30T09:58:39.015248001Z 09:58:39 rails.1              | started with pid 301
2025-07-30T09:58:39.015272290Z 09:58:39 default_worker.1     | started with pid 302
2025-07-30T09:58:39.015294345Z 09:58:39 performance_worker.1 | started with pid 303
2025-07-30T09:58:40.238923231Z 09:58:40 rails.1              | `/root` is not writable.
2025-07-30T09:58:40.238959695Z 09:58:40 rails.1              | Bundler will use `/tmp/bundler20250730-301-ml7c7j301' as your home directory temporarily.
2025-07-30T09:58:40.715351057Z 09:58:40 performance_worker.1 | `/root` is not writable.
2025-07-30T09:58:40.715384925Z 09:58:40 performance_worker.1 | Bundler will use `/tmp/bundler20250730-303-hj0scq303' as your home directory temporarily.
2025-07-30T09:58:40.726178158Z 09:58:40 default_worker.1     | `/root` is not writable.
2025-07-30T09:58:40.726218490Z 09:58:40 default_worker.1     | Bundler will use `/tmp/bundler20250730-302-cqyo6302' as your home directory temporarily.
2025-07-30T09:58:41.377324952Z 09:58:41 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-07-30T09:58:41.377368500Z 09:58:41 rails.1              | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-07-30T09:58:41.377405314Z 09:58:41 rails.1              | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-07-30T09:58:41.652372775Z 09:58:41 rails.1              | => Booting Puma
2025-07-30T09:58:41.652403998Z 09:58:41 rails.1              | => Rails 8.0.2 application starting in production 
2025-07-30T09:58:41.652413978Z 09:58:41 rails.1              | => Run `bin/rails server --help` for more startup options
2025-07-30T09:58:41.822791253Z 09:58:41 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-07-30T09:58:41.822832797Z 09:58:41 default_worker.1     | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-07-30T09:58:41.822845082Z 09:58:41 default_worker.1     | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-07-30T09:58:41.840987293Z 09:58:41 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-07-30T09:58:41.841030219Z 09:58:41 performance_worker.1 | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-07-30T09:58:41.841108587Z 09:58:41 performance_worker.1 | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-07-30T09:58:42.279981982Z 09:58:42 performance_worker.1 | Server: 0cb4bc9de9aa, Context: rails, Role: web, data: {cpu: {one_min: 2.62, five_min: 3.87, fifteen_min: 3.64}, memory: 0.18546688e9, disk: {available: 857548054528, total: 938656133120, used: 81108078592}}
2025-07-30T09:58:42.300550550Z 09:58:42 default_worker.1     | Server: 0cb4bc9de9aa, Context: rails, Role: web, data: {cpu: {one_min: 2.62, five_min: 3.87, fifteen_min: 3.64}, memory: 0.192364544e9, disk: {available: 857547927552, total: 938656133120, used: 81108205568}}
2025-07-30T09:58:44.213679499Z 09:58:44 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:44.214459680Z 09:58:44 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:44.215211954Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.214Z pid=302 tid=212: Sidekiq 8.0.6 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-07-30T09:58:44.215633483Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.215Z pid=303 tid=213: Sidekiq 8.0.6 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-07-30T09:58:44.221454946Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.221Z pid=302 tid=212: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-07-30T09:58:44.221474325Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.221Z pid=303 tid=213: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-07-30T09:58:44.224230414Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.223Z pid=302 tid=212: Cron Jobs - added job with name clear-downloads in the namespace default
2025-07-30T09:58:44.224708076Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.224Z pid=303 tid=213: Cron Jobs - added job with name clear-downloads in the namespace default
2025-07-30T09:58:44.295359431Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.294Z pid=302 tid=212: Booted Rails 8.0.2 application in production environment
2025-07-30T09:58:44.295390704Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.295Z pid=302 tid=212: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-07-30T09:58:44.295574404Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.295Z pid=302 tid=212: See LICENSE and the LGPL-3.0 for licensing details.
2025-07-30T09:58:44.295598803Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.295Z pid=302 tid=212: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-07-30T09:58:44.297584101Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.297Z pid=303 tid=213: Booted Rails 8.0.2 application in production environment
2025-07-30T09:58:44.297619111Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.297Z pid=303 tid=213: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-07-30T09:58:44.297785627Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.297Z pid=303 tid=213: See LICENSE and the LGPL-3.0 for licensing details.
2025-07-30T09:58:44.297828092Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.297Z pid=303 tid=213: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-07-30T09:58:44.297935057Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.297Z pid=302 tid=212: Sidekiq 8.0.6 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-07-30T09:58:44.306623743Z 09:58:44 performance_worker.1 | INFO  2025-07-30T09:58:44.299Z pid=303 tid=213: Sidekiq 8.0.6 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-07-30T09:58:44.402353186Z 09:58:44 rails.1              | Server: 0cb4bc9de9aa, Context: rails, Role: web, data: {cpu: {one_min: 2.62, five_min: 3.87, fifteen_min: 3.64}, memory: 0.171319296e9, disk: {available: 857548201984, total: 938656133120, used: 81107931136}}
2025-07-30T09:58:44.402386423Z 09:58:44 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:44.402390672Z 09:58:44 rails.1              | INFO  2025-07-30T09:58:44.215Z pid=301 tid=2d1: Sidekiq 8.0.6 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-07-30T09:58:44.402414369Z 09:58:44 rails.1              | INFO  2025-07-30T09:58:44.221Z pid=301 tid=2d1: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-07-30T09:58:44.402452566Z 09:58:44 rails.1              | INFO  2025-07-30T09:58:44.224Z pid=301 tid=2d1: Cron Jobs - added job with name clear-downloads in the namespace default
2025-07-30T09:58:44.402502286Z 09:58:44 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 015dbaf3-8365-4104-904e-36b0c90c3c80) to Sidekiq(upgrade)
2025-07-30T09:58:44.402553209Z 09:58:44 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: c84bc791-2db8-4d11-abfb-83a1332427b0) to Sidekiq(upgrade)
2025-07-30T09:58:44.402600404Z 09:58:44 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 4be5cb44-8120-4577-bac8-466c4c2a3323) to Sidekiq(upgrade)
2025-07-30T09:58:44.402645044Z 09:58:44 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 8cc64dc2-48bb-4594-8cea-1bec271ac6c3) to Sidekiq(upgrade)
2025-07-30T09:58:44.402695415Z 09:58:44 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: fec7c18d-7ebd-4ff6-a5d9-da4ca3ca3f1c) to Sidekiq(upgrade)
2025-07-30T09:58:44.402742390Z 09:58:44 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: 5da6e1ca-02a6-4324-86ac-62bf8c7a758d) to Sidekiq(upgrade)
2025-07-30T09:58:44.402795316Z 09:58:44 rails.1              | [301] Puma starting in cluster mode...
2025-07-30T09:58:44.402839445Z 09:58:44 rails.1              | [301] * Puma version: 6.6.0 ("Return to Forever")
2025-07-30T09:58:44.402889556Z 09:58:44 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-07-30T09:58:44.402938475Z 09:58:44 rails.1              | [301] *  Min threads: 4
2025-07-30T09:58:44.402987934Z 09:58:44 rails.1              | [301] *  Max threads: 16
2025-07-30T09:58:44.403039268Z 09:58:44 rails.1              | [301] *  Environment: production
2025-07-30T09:58:44.403085641Z 09:58:44 rails.1              | [301] *   Master PID: 301
2025-07-30T09:58:44.403132145Z 09:58:44 rails.1              | [301] *      Workers: 4
2025-07-30T09:58:44.403183438Z 09:58:44 rails.1              | [301] *     Restarts: (✔) hot (✖) phased
2025-07-30T09:58:44.403233789Z 09:58:44 rails.1              | [301] * Preloading application
2025-07-30T09:58:44.403286415Z 09:58:44 rails.1              | [301] * Listening on http://[::]:3214
2025-07-30T09:58:44.403333500Z 09:58:44 rails.1              | [301] Use Ctrl-C to stop
2025-07-30T09:58:44.428597693Z 09:58:44 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-07-30T09:58:44.428618825Z 09:58:44 rails.1              | [301] - Worker 1 (PID: 385) booted in 0.01s, phase: 0
2025-07-30T09:58:44.428690730Z 09:58:44 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-07-30T09:58:44.430216933Z 09:58:44 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-07-30T09:58:44.573310650Z 09:58:44 performance_worker.1 | Server: 0cb4bc9de9aa, Context: sidekiq, Role: background, data: {cpu: {one_min: 2.89, five_min: 3.9, fifteen_min: 3.65}, memory: 0.233152512e9, disk: {available: 857542201344, total: 938656133120, used: 81113931776}}
2025-07-30T09:58:44.577624577Z 09:58:44 default_worker.1     | Server: 0cb4bc9de9aa, Context: sidekiq, Role: background, data: {cpu: {one_min: 2.89, five_min: 3.9, fifteen_min: 3.65}, memory: 0.231387136e9, disk: {available: 857542201344, total: 938656133120, used: 81113931776}}
2025-07-30T09:58:44.667918765Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.577Z pid=302 tid=lb2 jid=feea2ec11ed944ebe909686c class=Upgrade::FixNilFileSizeValues: start
2025-07-30T09:58:44.669753089Z 09:58:44 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [015dbaf3-8365-4104-904e-36b0c90c3c80] Performing Upgrade::FixNilFileSizeValues (Job ID: 015dbaf3-8365-4104-904e-36b0c90c3c80) from Sidekiq(upgrade) enqueued at 2025-07-30T09:58:44.236995478Z
2025-07-30T09:58:44.670569212Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.667Z pid=302 tid=lau jid=7870d81ffa30fda43a05c660 class=Upgrade::BackfillDataPackages: start
2025-07-30T09:58:44.672312412Z 09:58:44 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [c84bc791-2db8-4d11-abfb-83a1332427b0] Performing Upgrade::BackfillDataPackages (Job ID: c84bc791-2db8-4d11-abfb-83a1332427b0) from Sidekiq(upgrade) enqueued at 2025-07-30T09:58:44.239230258Z
2025-07-30T09:58:44.679597191Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.668Z pid=302 tid=kz2 jid=b23af357a98e2060d4f3e27c class=Upgrade::DisambiguateUsernamesJob: start
2025-07-30T09:58:44.699163921Z 09:58:44 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [4be5cb44-8120-4577-bac8-466c4c2a3323] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 4be5cb44-8120-4577-bac8-466c4c2a3323) from Sidekiq(upgrade) enqueued at 2025-07-30T09:58:44.239924747Z
2025-07-30T09:58:44.700643581Z 09:58:44 default_worker.1     | INFO  2025-07-30T09:58:44.669Z pid=302 tid=kym jid=e605fa2f98dfa491cf181b89 class=Upgrade::UpdateActorsJob: start
2025-07-30T09:58:44.707657133Z 09:58:44 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [8cc64dc2-48bb-4594-8cea-1bec271ac6c3] Performing Upgrade::UpdateActorsJob (Job ID: 8cc64dc2-48bb-4594-8cea-1bec271ac6c3) from Sidekiq(upgrade) enqueued at 2025-07-30T09:58:44.240535817Z
2025-07-30T09:58:44.717719986Z 09:58:44 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [4be5cb44-8120-4577-bac8-466c4c2a3323] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:44.723780439Z 09:58:44 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [c84bc791-2db8-4d11-abfb-83a1332427b0] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:44.749973713Z 09:58:44 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [8cc64dc2-48bb-4594-8cea-1bec271ac6c3] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:44.895052487Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-07-30T09:58:44.896285530Z s6-rc: info: service svc-manyfold successfully started
2025-07-30T09:58:44.896603670Z s6-rc: info: service legacy-services: starting
2025-07-30T09:58:44.909301539Z s6-rc: info: service legacy-services successfully started
2025-07-30T09:58:44.909518756Z s6-rc: info: service ci-service-check: starting
2025-07-30T09:58:44.912885295Z [ls.io-init] done.
2025-07-30T09:58:44.913654765Z s6-rc: info: service ci-service-check successfully started
2025-07-30T09:58:45.031779974Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [015dbaf3-8365-4104-904e-36b0c90c3c80] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:45.093273438Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [015dbaf3-8365-4104-904e-36b0c90c3c80] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-07-30T09:58:45.099670510Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [015dbaf3-8365-4104-904e-36b0c90c3c80] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.042
2025-07-30T09:58:45.120976772Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [4be5cb44-8120-4577-bac8-466c4c2a3323] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 4be5cb44-8120-4577-bac8-466c4c2a3323) from Sidekiq(upgrade) in 421.81ms
2025-07-30T09:58:45.121762495Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [8cc64dc2-48bb-4594-8cea-1bec271ac6c3] Performed Upgrade::UpdateActorsJob (Job ID: 8cc64dc2-48bb-4594-8cea-1bec271ac6c3) from Sidekiq(upgrade) in 414.57ms
2025-07-30T09:58:45.122649691Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.122Z pid=302 tid=kz2 jid=b23af357a98e2060d4f3e27c class=Upgrade::DisambiguateUsernamesJob elapsed=0.454: done
2025-07-30T09:58:45.131627159Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [c84bc791-2db8-4d11-abfb-83a1332427b0] Performed Upgrade::BackfillDataPackages (Job ID: c84bc791-2db8-4d11-abfb-83a1332427b0) from Sidekiq(upgrade) in 448.82ms
2025-07-30T09:58:45.131893725Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.131Z pid=302 tid=kym jid=e605fa2f98dfa491cf181b89 class=Upgrade::UpdateActorsJob elapsed=0.461: done
2025-07-30T09:58:45.132074008Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [015dbaf3-8365-4104-904e-36b0c90c3c80] Performed Upgrade::FixNilFileSizeValues (Job ID: 015dbaf3-8365-4104-904e-36b0c90c3c80) from Sidekiq(upgrade) in 461.98ms
2025-07-30T09:58:45.132505988Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.131Z pid=302 tid=kz2 jid=1199b79bc4b26e9fff3e960b class=Upgrade::FixParentCollections: start
2025-07-30T09:58:45.133299576Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [fec7c18d-7ebd-4ff6-a5d9-da4ca3ca3f1c] Performing Upgrade::FixParentCollections (Job ID: fec7c18d-7ebd-4ff6-a5d9-da4ca3ca3f1c) from Sidekiq(upgrade) enqueued at 2025-07-30T09:58:44.241142108Z
2025-07-30T09:58:45.133746747Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.131Z pid=302 tid=lau jid=7870d81ffa30fda43a05c660 class=Upgrade::BackfillDataPackages elapsed=0.464: done
2025-07-30T09:58:45.133779332Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.132Z pid=302 tid=kym jid=288c1271e5da48a06f190b0d class=Upgrade::PruneOrphanedProblems: start
2025-07-30T09:58:45.134673152Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [5da6e1ca-02a6-4324-86ac-62bf8c7a758d] Performing Upgrade::PruneOrphanedProblems (Job ID: 5da6e1ca-02a6-4324-86ac-62bf8c7a758d) from Sidekiq(upgrade) enqueued at 2025-07-30T09:58:44.241780644Z
2025-07-30T09:58:45.135237569Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.132Z pid=302 tid=lb2 jid=feea2ec11ed944ebe909686c class=Upgrade::FixNilFileSizeValues elapsed=0.555: done
2025-07-30T09:58:45.158595092Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [fec7c18d-7ebd-4ff6-a5d9-da4ca3ca3f1c] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:45.248711572Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [5da6e1ca-02a6-4324-86ac-62bf8c7a758d] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-30T09:58:45.410593261Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [5da6e1ca-02a6-4324-86ac-62bf8c7a758d] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-07-30T09:58:45.410736790Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [5da6e1ca-02a6-4324-86ac-62bf8c7a758d] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.074
2025-07-30T09:58:45.411407410Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [fec7c18d-7ebd-4ff6-a5d9-da4ca3ca3f1c] Performed Upgrade::FixParentCollections (Job ID: fec7c18d-7ebd-4ff6-a5d9-da4ca3ca3f1c) from Sidekiq(upgrade) in 278.2ms
2025-07-30T09:58:45.431436872Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.431Z pid=302 tid=kz2 jid=1199b79bc4b26e9fff3e960b class=Upgrade::FixParentCollections elapsed=0.3: done
2025-07-30T09:58:45.435389702Z 09:58:45 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [5da6e1ca-02a6-4324-86ac-62bf8c7a758d] Performed Upgrade::PruneOrphanedProblems (Job ID: 5da6e1ca-02a6-4324-86ac-62bf8c7a758d) from Sidekiq(upgrade) in 296.93ms
2025-07-30T09:58:45.443291262Z 09:58:45 default_worker.1     | INFO  2025-07-30T09:58:45.442Z pid=302 tid=kym jid=288c1271e5da48a06f190b0d class=Upgrade::PruneOrphanedProblems elapsed=0.31: done
2025-07-30T09:59:14.941271420Z 09:59:14 rails.1              | [bf104143-c0a5-446a-b776-a4126b4d74a9] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1390,"duration":33.75,"view":0.0,"db":4.76,"@timestamp":"2025-07-30T09:59:14.939Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-07-30T09:59:15.938601917Z 09:59:15 rails.1              | [a4a7c642-a46e-40fb-8ce0-1a41f76f3b5b] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":94165,"duration":976.17,"view":0.0,"db":24.49,"location":"http://172.17.0.5:3214/","@timestamp":"2025-07-30T09:59:15.938Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-07-30T09:59:15.978706052Z 09:59:15 rails.1              | [10bebcdf-fab0-4d9e-bb62-eb33fb91c023] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1052,"duration":21.36,"view":0.0,"db":0.51,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-07-30T09:59:15.965Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-07-30T09:59:16.630186257Z 09:59:16 rails.1              | [a3ce5dfc-67ed-44e6-87b7-b119868e2e87] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24275,"duration":630.56,"view":503.0,"db":64.76,"@timestamp":"2025-07-30T09:59:16.629Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-07-30T09:59:16.704470707Z 09:59:16 rails.1              | [94e9f21d-c83f-401f-8083-075be51fbed6] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1183,"duration":29.94,"view":0.0,"db":3.98,"@timestamp":"2025-07-30T09:59:16.703Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-07-30T09:59:17.049020170Z 09:59:17 rails.1              | [52f0efb9-28fd-4b6e-8556-a10d3784517a] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14493,"duration":232.11,"view":0.0,"db":1.59,"location":"http://172.17.0.5:3214/","@timestamp":"2025-07-30T09:59:17.012Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-07-30T09:59:17.078563760Z 09:59:17 rails.1              | [faee3685-1457-416c-a17e-997f5dbf4c09] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1087,"duration":22.6,"view":0.0,"db":1.99,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-07-30T09:59:17.078Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-07-30T09:59:17.448995238Z 09:59:17 rails.1              | [d6999c24-4498-4b44-b5c9-452855bd18bb] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24484,"duration":350.06,"view":225.2,"db":1.14,"@timestamp":"2025-07-30T09:59:17.443Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}