2025-08-12T13:30:05.131516939Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-08-12T13:30:05.131536588Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-08-12T13:30:05.178626248Z [mod-init] Running Docker Modification Logic
2025-08-12T13:30:05.517811225Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-08-12T13:30:09.755177389Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-08-12T13:30:10.110795161Z [mod-init] Installing linuxserver/mods:universal-redis
2025-08-12T13:30:10.132984130Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-08-12T13:30:10.133984515Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-08-12T13:30:10.149235831Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-08-12T13:30:10.151471815Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-08-12T13:30:10.151556325Z s6-rc: info: service fix-attrs: starting
2025-08-12T13:30:10.151661146Z s6-rc: info: service init-migrations: starting
2025-08-12T13:30:10.151782160Z s6-rc: info: service init-envfile: starting
2025-08-12T13:30:10.156628841Z s6-rc: info: service fix-attrs successfully started
2025-08-12T13:30:10.156753783Z s6-rc: info: service legacy-cont-init: starting
2025-08-12T13:30:10.156999026Z [migrations] started
2025-08-12T13:30:10.157053707Z [migrations] no migrations found
2025-08-12T13:30:10.157438101Z s6-rc: info: service init-migrations successfully started
2025-08-12T13:30:10.157529986Z s6-rc: info: service init-adduser: starting
2025-08-12T13:30:10.159235160Z s6-rc: info: service init-envfile successfully started
2025-08-12T13:30:10.161359909Z s6-rc: info: service legacy-cont-init successfully started
2025-08-12T13:30:10.184279390Z usermod: no changes
2025-08-12T13:30:10.190480429Z ───────────────────────────────────────
2025-08-12T13:30:10.190502323Z 
2025-08-12T13:30:10.190506471Z       ██╗     ███████╗██╗ ██████╗
2025-08-12T13:30:10.190510429Z       ██║     ██╔════╝██║██╔═══██╗
2025-08-12T13:30:10.190514277Z       ██║     ███████╗██║██║   ██║
2025-08-12T13:30:10.190518115Z       ██║     ╚════██║██║██║   ██║
2025-08-12T13:30:10.190522053Z       ███████╗███████║██║╚██████╔╝
2025-08-12T13:30:10.190526021Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-08-12T13:30:10.190530009Z 
2025-08-12T13:30:10.190533596Z    Brought to you by linuxserver.io
2025-08-12T13:30:10.190546492Z ───────────────────────────────────────
2025-08-12T13:30:10.190837969Z 
2025-08-12T13:30:10.190843029Z To support LSIO projects visit:
2025-08-12T13:30:10.190846927Z https://www.linuxserver.io/donate/
2025-08-12T13:30:10.190851286Z 
2025-08-12T13:30:10.190854783Z ───────────────────────────────────────
2025-08-12T13:30:10.190859232Z GID/UID
2025-08-12T13:30:10.190862849Z ───────────────────────────────────────
2025-08-12T13:30:10.194800149Z 
2025-08-12T13:30:10.194809869Z User UID:    911
2025-08-12T13:30:10.194813686Z User GID:    911
2025-08-12T13:30:10.194817504Z ───────────────────────────────────────
2025-08-12T13:30:10.196426024Z Linuxserver.io version: v0.121.0-ls98
2025-08-12T13:30:10.196688091Z Build-date: 2025-08-12T13:17:12+00:00
2025-08-12T13:30:10.196700807Z ───────────────────────────────────────
2025-08-12T13:30:10.196706869Z     
2025-08-12T13:30:10.213903694Z s6-rc: info: service init-adduser successfully started
2025-08-12T13:30:10.214040329Z s6-rc: info: service init-device-perms: starting
2025-08-12T13:30:10.219468912Z s6-rc: info: service init-device-perms successfully started
2025-08-12T13:30:10.219595167Z s6-rc: info: service init-os-end: starting
2025-08-12T13:30:10.220815845Z s6-rc: info: service init-os-end successfully started
2025-08-12T13:30:10.221039305Z s6-rc: info: service init-manyfold-config: starting
2025-08-12T13:30:10.221063534Z s6-rc: info: service init-config: starting
2025-08-12T13:30:10.222124230Z s6-rc: info: service init-config successfully started
2025-08-12T13:30:10.222220825Z s6-rc: info: service init-crontab-config: starting
2025-08-12T13:30:10.233665675Z s6-rc: info: service init-crontab-config successfully started
2025-08-12T13:30:10.250712909Z **** Running Manyfold database init. ****
2025-08-12T13:30:12.695697773Z `/root` is not writable.
2025-08-12T13:30:12.695962266Z Bundler will use `/tmp/bundler20250812-173-fvgjhp173' as your home directory temporarily.
2025-08-12T13:30:15.500928108Z /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-08-12T13:30:15.500964451Z You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-12T13:30:15.500974291Z Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-12T13:30:19.837928697Z Server: cfa63cddd513, Context: rails, Role: web, data: {cpu: {one_min: 3.69, five_min: 2.31, fifteen_min: 2.13}, memory: 0.22622208e9, disk: {available: 853758308352, total: 938656133120, used: 84897824768}}
2025-08-12T13:30:19.837966033Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-08-12T13:30:19.837975081Z INFO  2025-08-12T13:30:17.714Z pid=173 tid=29h: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-12T13:30:19.837983518Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-08-12T13:30:19.837991354Z Migrating to CreateLibraries (20210130201037)
2025-08-12T13:30:19.837998688Z == 20210130201037 CreateLibraries: migrating ==================================
2025-08-12T13:30:19.838006234Z -- create_table(:libraries)
2025-08-12T13:30:19.838013408Z    -> 0.0030s
2025-08-12T13:30:19.838020633Z == 20210130201037 CreateLibraries: migrated (0.0030s) =========================
2025-08-12T13:30:19.838028358Z 
2025-08-12T13:30:19.838037136Z Migrating to CreateModels (20210130203243)
2025-08-12T13:30:19.838046294Z == 20210130203243 CreateModels: migrating =====================================
2025-08-12T13:30:19.838053649Z -- create_table(:models)
2025-08-12T13:30:19.838060733Z    -> 0.0022s
2025-08-12T13:30:19.838067888Z == 20210130203243 CreateModels: migrated (0.0022s) ============================
2025-08-12T13:30:19.838075293Z 
2025-08-12T13:30:19.838082377Z Migrating to CreateParts (20210205230918)
2025-08-12T13:30:19.838089501Z == 20210205230918 CreateParts: migrating ======================================
2025-08-12T13:30:19.838096786Z -- create_table(:parts)
2025-08-12T13:30:19.838103780Z    -> 0.0035s
2025-08-12T13:30:19.838111506Z == 20210205230918 CreateParts: migrated (0.0035s) =============================
2025-08-12T13:30:19.838120614Z 
2025-08-12T13:30:19.838129071Z Migrating to AddFieldsToParts (20210210153744)
2025-08-12T13:30:19.838136255Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-08-12T13:30:19.838143390Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-08-12T13:30:19.838150695Z    -> 0.0008s
2025-08-12T13:30:19.838157729Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-08-12T13:30:19.838164893Z    -> 0.0003s
2025-08-12T13:30:19.838171927Z == 20210210153744 AddFieldsToParts: migrated (0.0012s) ========================
2025-08-12T13:30:19.838179092Z 
2025-08-12T13:30:19.838186036Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-08-12T13:30:19.838194042Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-08-12T13:30:19.838228000Z -- create_table(:tags, {id: :integer})
2025-08-12T13:30:19.838235545Z    -> 0.0042s
2025-08-12T13:30:19.838242620Z -- create_table(:taggings, {id: :integer})
2025-08-12T13:30:19.838249734Z    -> 0.0018s
2025-08-12T13:30:19.838256788Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-12T13:30:19.838264243Z    -> 0.0002s
2025-08-12T13:30:19.838273091Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-08-12T13:30:19.838282710Z    -> 0.0024s
2025-08-12T13:30:19.838291598Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0088s) ===============
2025-08-12T13:30:19.838298963Z 
2025-08-12T13:30:19.838306128Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-08-12T13:30:19.838313342Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-08-12T13:30:19.838320537Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-08-12T13:30:19.838327841Z    -> 0.0004s
2025-08-12T13:30:19.838334956Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-12T13:30:19.838342250Z    -> 0.0004s
2025-08-12T13:30:19.838349294Z -- remove_foreign_key(:taggings, :tags)
2025-08-12T13:30:19.838357251Z    -> 0.1854s
2025-08-12T13:30:19.838366058Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-12T13:30:19.838374716Z    -> 0.0166s
2025-08-12T13:30:19.838381800Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-08-12T13:30:19.838389135Z    -> 0.0002s
2025-08-12T13:30:19.838396279Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-08-12T13:30:19.838404005Z    -> 0.0053s
2025-08-12T13:30:19.838411209Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-08-12T13:30:19.838418634Z    -> 0.0759s
2025-08-12T13:30:19.838425799Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3189s) =================
2025-08-12T13:30:19.838432662Z 
2025-08-12T13:30:19.838440208Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-08-12T13:30:19.838448174Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-08-12T13:30:19.838455318Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-08-12T13:30:19.838461741Z    -> 0.0369s
2025-08-12T13:30:19.838468084Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1181s) ===========
2025-08-12T13:30:19.838474497Z 
2025-08-12T13:30:19.838480529Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-08-12T13:30:19.838495068Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-08-12T13:30:19.838501501Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-08-12T13:30:19.838508134Z    -> 0.0003s
2025-08-12T13:30:19.838514808Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-08-12T13:30:19.838522694Z 
2025-08-12T13:30:19.838530359Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-08-12T13:30:19.838536692Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-08-12T13:30:19.838542985Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0007s) ==============
2025-08-12T13:30:19.838549227Z 
2025-08-12T13:30:19.838555179Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-08-12T13:30:19.838561392Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-08-12T13:30:19.838568235Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-12T13:30:19.838574698Z    -> 0.0084s
2025-08-12T13:30:19.838580871Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-08-12T13:30:19.838587284Z    -> 0.0002s
2025-08-12T13:30:19.838593697Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-08-12T13:30:19.838601563Z    -> 0.0062s
2025-08-12T13:30:19.838609218Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-08-12T13:30:19.838615952Z    -> 0.0012s
2025-08-12T13:30:19.838622174Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-08-12T13:30:19.838628627Z    -> 0.0004s
2025-08-12T13:30:19.838634759Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-08-12T13:30:19.838641172Z    -> 0.0001s
2025-08-12T13:30:19.838647305Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-08-12T13:30:19.838653688Z    -> 0.0040s
2025-08-12T13:30:19.838659850Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-08-12T13:30:19.838666243Z    -> 0.0002s
2025-08-12T13:30:19.838672435Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-08-12T13:30:19.838680201Z    -> 0.0006s
2025-08-12T13:30:19.838690572Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-08-12T13:30:19.838697085Z    -> 0.0001s
2025-08-12T13:30:19.838703277Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-08-12T13:30:19.838709871Z    -> 0.0006s
2025-08-12T13:30:19.838724039Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-08-12T13:30:19.838730673Z    -> 0.0001s
2025-08-12T13:30:19.838736925Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-08-12T13:30:19.838743478Z    -> 0.0015s
2025-08-12T13:30:19.838749691Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-08-12T13:30:19.838757066Z    -> 0.0002s
2025-08-12T13:30:19.838764861Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0242s) =============
2025-08-12T13:30:19.838772447Z 
2025-08-12T13:30:19.838778489Z Migrating to AddPreviewPartToModel (20210220204055)
2025-08-12T13:30:19.838784721Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-08-12T13:30:19.838791044Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-08-12T13:30:19.838797337Z    -> 0.2660s
2025-08-12T13:30:19.838803449Z == 20210220204055 AddPreviewPartToModel: migrated (0.2661s) ===================
2025-08-12T13:30:19.838809732Z 
2025-08-12T13:30:19.838815724Z Migrating to CreateCreators (20210225232756)
2025-08-12T13:30:19.838821906Z == 20210225232756 CreateCreators: migrating ===================================
2025-08-12T13:30:19.838828179Z -- create_table(:creators)
2025-08-12T13:30:19.838834782Z    -> 0.0151s
2025-08-12T13:30:19.838842488Z == 20210225232756 CreateCreators: migrated (0.0151s) ==========================
2025-08-12T13:30:19.838850314Z 
2025-08-12T13:30:19.838856997Z Migrating to AddCreatorToModels (20210225232841)
2025-08-12T13:30:19.838863310Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-08-12T13:30:19.838869602Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-08-12T13:30:19.838875905Z    -> 0.0581s
2025-08-12T13:30:19.838882067Z == 20210225232841 AddCreatorToModels: migrated (0.0581s) ======================
2025-08-12T13:30:19.838888360Z 
2025-08-12T13:30:19.838894492Z Migrating to CreateLinks (20210301230017)
2025-08-12T13:30:19.838900725Z == 20210301230017 CreateLinks: migrating ======================================
2025-08-12T13:30:19.838907038Z -- create_table(:links)
2025-08-12T13:30:19.838913571Z    -> 0.0008s
2025-08-12T13:30:19.838921226Z == 20210301230017 CreateLinks: migrated (0.0008s) =============================
2025-08-12T13:30:19.838929092Z 
2025-08-12T13:30:19.838935796Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-08-12T13:30:19.838942179Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-08-12T13:30:19.838956407Z -- remove_column(:creators, :thingiverse_user, :string)
2025-08-12T13:30:19.838962710Z    -> 0.0709s
2025-08-12T13:30:19.838968892Z -- remove_column(:creators, :cults3d_user, :string)
2025-08-12T13:30:19.838975145Z    -> 0.0050s
2025-08-12T13:30:19.838981297Z -- remove_column(:creators, :mmf_user, :string)
2025-08-12T13:30:19.838987540Z    -> 0.0151s
2025-08-12T13:30:19.838993722Z -- remove_column(:creators, :cgtrader_user, :string)
2025-08-12T13:30:19.839001548Z    -> 0.0035s
2025-08-12T13:30:19.839009244Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0966s) ==============
2025-08-12T13:30:19.839016017Z 
2025-08-12T13:30:19.839022079Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-08-12T13:30:19.839028372Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-08-12T13:30:19.839034635Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-08-12T13:30:19.839040947Z    -> 0.0624s
2025-08-12T13:30:19.839047140Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0624s) ==
2025-08-12T13:30:19.839053453Z 
2025-08-12T13:30:19.839059555Z Migrating to AddYUpToParts (20210318202638)
2025-08-12T13:30:19.839065777Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-08-12T13:30:19.839072090Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-08-12T13:30:19.839079425Z    -> 0.0164s
2025-08-12T13:30:19.839087201Z == 20210318202638 AddYUpToParts: migrated (0.0165s) ===========================
2025-08-12T13:30:19.839094435Z 
2025-08-12T13:30:19.839100567Z Migrating to CreateImages (20210321164508)
2025-08-12T13:30:19.839106800Z == 20210321164508 CreateImages: migrating =====================================
2025-08-12T13:30:19.839113183Z -- create_table(:images)
2025-08-12T13:30:19.839119405Z    -> 0.0178s
2025-08-12T13:30:19.839125568Z == 20210321164508 CreateImages: migrated (0.0178s) ============================
2025-08-12T13:30:19.839131901Z 
2025-08-12T13:30:19.839137993Z Migrating to CreateDelayedJobs (20210330215825)
2025-08-12T13:30:19.839144286Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-08-12T13:30:19.839150648Z -- create_table(:delayed_jobs)
2025-08-12T13:30:19.839157662Z    -> 0.0097s
2025-08-12T13:30:20.826140135Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-08-12T13:30:20.826189374Z    -> 0.0002s
2025-08-12T13:30:20.826199394Z == 20210330215825 CreateDelayedJobs: migrated (0.0099s) =======================
2025-08-12T13:30:20.826207741Z 
2025-08-12T13:30:20.826239796Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-08-12T13:30:20.826248243Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-08-12T13:30:20.826256419Z -- rename_table(:parts, :model_files)
2025-08-12T13:30:20.826264706Z    -> 0.0016s
2025-08-12T13:30:20.826272662Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-08-12T13:30:20.826281129Z    -> 0.0354s
2025-08-12T13:30:20.826289365Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0370s) =================
2025-08-12T13:30:20.826297422Z 
2025-08-12T13:30:20.826305117Z Migrating to RemoveImagesTable (20220106220519)
2025-08-12T13:30:20.826313253Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-08-12T13:30:20.826321460Z -- drop_table(:images)
2025-08-12T13:30:20.826329446Z    -> 0.0004s
2025-08-12T13:30:20.826337332Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-08-12T13:30:20.826345679Z 
2025-08-12T13:30:20.826353485Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-08-12T13:30:20.826361451Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-08-12T13:30:20.826369607Z -- table_exists?(:active_storage_blobs)
2025-08-12T13:30:20.826377573Z    -> 0.0001s
2025-08-12T13:30:20.826385469Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-08-12T13:30:20.826393595Z 
2025-08-12T13:30:20.826401491Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-08-12T13:30:20.826409437Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-08-12T13:30:20.826417443Z -- table_exists?(:active_storage_blobs)
2025-08-12T13:30:20.826425369Z    -> 0.0001s
2025-08-12T13:30:20.826433245Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-08-12T13:30:20.826441261Z 
2025-08-12T13:30:20.826448977Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-08-12T13:30:20.826457033Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-08-12T13:30:20.826465089Z -- table_exists?(:active_storage_blobs)
2025-08-12T13:30:20.826472955Z    -> 0.0001s
2025-08-12T13:30:20.826480831Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-08-12T13:30:20.826488917Z 
2025-08-12T13:30:20.826496603Z Migrating to DeviseCreateUsers (20220614210023)
2025-08-12T13:30:20.826504739Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-08-12T13:30:20.826512916Z -- create_table(:users)
2025-08-12T13:30:20.826521353Z    -> 0.0012s
2025-08-12T13:30:20.826536403Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-08-12T13:30:20.826544800Z    -> 0.0016s
2025-08-12T13:30:20.826552676Z == 20220614210023 DeviseCreateUsers: migrated (0.0029s) =======================
2025-08-12T13:30:20.826560772Z 
2025-08-12T13:30:20.826568467Z Migrating to AddUsernameToUsers (20220614211256)
2025-08-12T13:30:20.826576363Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-08-12T13:30:20.826585963Z -- add_column(:users, :username, :string, {null: false})
2025-08-12T13:30:20.826594550Z    -> 0.0229s
2025-08-12T13:30:20.826602536Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-08-12T13:30:20.826610743Z    -> 0.0001s
2025-08-12T13:30:20.826618628Z == 20220614211256 AddUsernameToUsers: migrated (0.0231s) ======================
2025-08-12T13:30:20.826626695Z 
2025-08-12T13:30:20.826634410Z Migrating to AddAdminToUsers (20220614213902)
2025-08-12T13:30:20.826642396Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-08-12T13:30:20.826650392Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-08-12T13:30:20.826658569Z    -> 0.0005s
2025-08-12T13:30:20.826666715Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-08-12T13:30:20.826674932Z 
2025-08-12T13:30:20.826682938Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-08-12T13:30:20.826691145Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-08-12T13:30:20.826699231Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-08-12T13:30:20.826708399Z    -> 0.0012s
2025-08-12T13:30:20.826716375Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0013s) =============
2025-08-12T13:30:20.826724482Z 
2025-08-12T13:30:20.826732167Z Migrating to CreateSettings (20220619174307)
2025-08-12T13:30:20.826740123Z == 20220619174307 CreateSettings: migrating ===================================
2025-08-12T13:30:20.826748450Z -- create_table(:settings)
2025-08-12T13:30:20.826756396Z    -> 0.0030s
2025-08-12T13:30:20.826764242Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-08-12T13:30:20.826772428Z    -> 0.0002s
2025-08-12T13:30:20.826780334Z == 20220619174307 CreateSettings: migrated (0.0032s) ==========================
2025-08-12T13:30:20.826788410Z 
2025-08-12T13:30:20.826796216Z Migrating to AddScaleFactorToModels (20220626152444)
2025-08-12T13:30:20.826804162Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-08-12T13:30:20.826837820Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-08-12T13:30:20.826846227Z    -> 0.0103s
2025-08-12T13:30:20.826854453Z == 20220626152444 AddScaleFactorToModels: migrated (0.0126s) ==================
2025-08-12T13:30:20.826862560Z 
2025-08-12T13:30:20.826870345Z Migrating to AddDigestToModelFiles (20220702202932)
2025-08-12T13:30:20.826878412Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-08-12T13:30:20.826886478Z -- add_column(:model_files, :digest, :string)
2025-08-12T13:30:20.826894454Z    -> 0.0024s
2025-08-12T13:30:20.826902410Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-08-12T13:30:20.826910586Z    -> 0.0001s
2025-08-12T13:30:20.826918442Z == 20220702202932 AddDigestToModelFiles: migrated (0.0048s) ===================
2025-08-12T13:30:20.826926559Z 
2025-08-12T13:30:20.826934374Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-08-12T13:30:20.826942421Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-08-12T13:30:20.826950998Z -- add_column(:users, :renderer_settings, :json, {default: {"grid_width" => 200, "grid_depth" => 200, "show_grid" => true, "enable_pan_zoom" => false, "background_colour" => "#000000", "object_colour" => "#ffffff", "render_style" => "original"}})
2025-08-12T13:30:20.826962862Z    -> 0.0007s
2025-08-12T13:30:20.826970948Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0011s) ==============
2025-08-12T13:30:20.826979094Z 
2025-08-12T13:30:20.826986880Z Migrating to CreateProblems (20221210001132)
2025-08-12T13:30:20.826995077Z == 20221210001132 CreateProblems: migrating ===================================
2025-08-12T13:30:20.827003333Z -- create_table(:problems)
2025-08-12T13:30:20.827011470Z    -> 0.0010s
2025-08-12T13:30:20.827019847Z == 20221210001132 CreateProblems: migrated (0.0015s) ==========================
2025-08-12T13:30:20.827028013Z 
2025-08-12T13:30:20.827035769Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-08-12T13:30:20.827043815Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-08-12T13:30:20.827054206Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0187s) ========
2025-08-12T13:30:20.827062382Z 
2025-08-12T13:30:20.827070158Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-08-12T13:30:20.827078254Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-08-12T13:30:20.827086360Z -- create_table(:favorites, {force: true})
2025-08-12T13:30:20.827094347Z    -> 0.0048s
2025-08-12T13:30:20.827111651Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-08-12T13:30:20.827120309Z    -> 0.0001s
2025-08-12T13:30:20.827128215Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-08-12T13:30:20.827136662Z    -> 0.0001s
2025-08-12T13:30:20.827144658Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-08-12T13:30:20.827153746Z    -> 0.0001s
2025-08-12T13:30:20.827161622Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0057s) ================
2025-08-12T13:30:20.827169919Z 
2025-08-12T13:30:20.827177845Z Migrating to MovePrintedToFavorites (20221220223040)
2025-08-12T13:30:20.827185991Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-08-12T13:30:20.827194238Z == 20221220223040 MovePrintedToFavorites: migrated (0.3211s) ==================
2025-08-12T13:30:20.827202404Z 
2025-08-12T13:30:20.827210190Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-08-12T13:30:20.827218266Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-08-12T13:30:20.827226352Z -- remove_column(:model_files, :printed, :boolean)
2025-08-12T13:30:20.827234379Z    -> 0.0304s
2025-08-12T13:30:20.827242295Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0311s) ===============
2025-08-12T13:30:20.827250381Z 
2025-08-12T13:30:20.827258146Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-08-12T13:30:20.827266624Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-08-12T13:30:20.827274750Z -- add_column(:models, :notes, :text)
2025-08-12T13:30:20.827282776Z    -> 0.0014s
2025-08-12T13:30:20.827290682Z -- add_column(:models, :excerpt, :text)
2025-08-12T13:30:20.827298668Z    -> 0.0022s
2025-08-12T13:30:20.827307005Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0037s) =================
2025-08-12T13:30:20.827315091Z 
2025-08-12T13:30:20.827322847Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-08-12T13:30:20.827330803Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-08-12T13:30:20.827338969Z -- add_column(:creators, :notes, :text)
2025-08-12T13:30:20.827347206Z    -> 0.0007s
2025-08-12T13:30:20.827355282Z -- add_column(:creators, :excerpt, :text)
2025-08-12T13:30:20.827363348Z    -> 0.0004s
2025-08-12T13:30:20.827371435Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0012s) ===============
2025-08-12T13:30:20.827379611Z 
2025-08-12T13:30:20.827387657Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-08-12T13:30:20.827404511Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-08-12T13:30:20.827412597Z -- add_column(:model_files, :notes, :text)
2025-08-12T13:30:20.827420654Z    -> 0.0005s
2025-08-12T13:30:20.827428590Z -- add_column(:model_files, :excerpt, :text)
2025-08-12T13:30:20.827436566Z    -> 0.0005s
2025-08-12T13:30:20.827444562Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0010s) =============
2025-08-12T13:30:20.827452648Z 
2025-08-12T13:30:20.827460574Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-08-12T13:30:20.827468540Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-08-12T13:30:20.827476646Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0212s) =================
2025-08-12T13:30:20.827484753Z 
2025-08-12T13:30:20.827492559Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-08-12T13:30:20.827500545Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-08-12T13:30:20.827508801Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-08-12T13:30:20.827517228Z    -> 0.0452s
2025-08-12T13:30:20.827525315Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0452s) =============
2025-08-12T13:30:20.827533511Z 
2025-08-12T13:30:20.827541357Z Migrating to RenameExcerptToCaption (20230222155910)
2025-08-12T13:30:20.827549363Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-08-12T13:30:20.827557409Z -- rename_column(:creators, :excerpt, :caption)
2025-08-12T13:30:20.827565325Z    -> 0.0227s
2025-08-12T13:30:20.827573251Z -- rename_column(:models, :excerpt, :caption)
2025-08-12T13:30:20.827581237Z    -> 0.0218s
2025-08-12T13:30:20.827589133Z -- rename_column(:model_files, :excerpt, :caption)
2025-08-12T13:30:20.827597119Z    -> 0.0204s
2025-08-12T13:30:20.827605025Z == 20230222155910 RenameExcerptToCaption: migrated (0.0675s) ==================
2025-08-12T13:30:20.827613322Z 
2025-08-12T13:30:20.827621097Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-08-12T13:30:20.827629154Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-08-12T13:30:20.827637210Z -- add_column(:libraries, :notes, :string)
2025-08-12T13:30:20.827645156Z    -> 0.0021s
2025-08-12T13:30:20.827653112Z -- add_column(:libraries, :caption, :string)
2025-08-12T13:30:21.351332032Z    -> 0.0004s
2025-08-12T13:30:21.351373005Z -- add_column(:libraries, :name, :string)
2025-08-12T13:30:21.351382434Z    -> 0.0004s
2025-08-12T13:30:21.351409719Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0125s) ============
2025-08-12T13:30:21.351418236Z 
2025-08-12T13:30:21.351426252Z Migrating to AddTagregexToLibrary (20230305180823)
2025-08-12T13:30:21.351434328Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-08-12T13:30:21.351442435Z -- add_column(:libraries, :tag_regex, :text)
2025-08-12T13:30:21.351450541Z    -> 0.0020s
2025-08-12T13:30:21.351458607Z == 20230305180823 AddTagregexToLibrary: migrated (0.0038s) ====================
2025-08-12T13:30:21.351466814Z 
2025-08-12T13:30:21.351474730Z Migrating to AddIconToLibrary (20230307215826)
2025-08-12T13:30:21.351482956Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-08-12T13:30:21.351491163Z -- add_column(:libraries, :icon, :text)
2025-08-12T13:30:21.351499389Z    -> 0.0019s
2025-08-12T13:30:21.351507696Z == 20230307215826 AddIconToLibrary: migrated (0.0036s) ========================
2025-08-12T13:30:21.351515862Z 
2025-08-12T13:30:21.351523728Z Migrating to CreateCollection (20230308004237)
2025-08-12T13:30:21.351531744Z == 20230308004237 CreateCollection: migrating =================================
2025-08-12T13:30:21.351539841Z -- create_table(:collections)
2025-08-12T13:30:21.351547787Z    -> 0.0030s
2025-08-12T13:30:21.351555673Z == 20230308004237 CreateCollection: migrated (0.0073s) ========================
2025-08-12T13:30:21.351563769Z 
2025-08-12T13:30:21.351571765Z Migrating to AddCollectionToModels (20230308005021)
2025-08-12T13:30:21.351579791Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-08-12T13:30:21.351587867Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-08-12T13:30:21.351595924Z    -> 0.0178s
2025-08-12T13:30:21.351603820Z == 20230308005021 AddCollectionToModels: migrated (0.0215s) ===================
2025-08-12T13:30:21.351611926Z 
2025-08-12T13:30:21.351619671Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-08-12T13:30:21.351627748Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-08-12T13:30:21.351635924Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0014s) =============
2025-08-12T13:30:21.351644131Z 
2025-08-12T13:30:21.351652007Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-08-12T13:30:21.351660113Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-08-12T13:30:21.351668259Z -- rename_column(:collections, :excerpt, :caption)
2025-08-12T13:30:21.351676275Z    -> 0.0040s
2025-08-12T13:30:21.351684131Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0040s) ========
2025-08-12T13:30:21.351701396Z 
2025-08-12T13:30:21.351709312Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-08-12T13:30:21.351717318Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-08-12T13:30:21.351725424Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-08-12T13:30:21.351733681Z 
2025-08-12T13:30:21.351741537Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-08-12T13:30:21.351751136Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-08-12T13:30:21.351759523Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-08-12T13:30:21.351769163Z    -> 0.0023s
2025-08-12T13:30:21.351777309Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0024s) ===============
2025-08-12T13:30:21.351785596Z 
2025-08-12T13:30:21.351793522Z Migrating to AddCollectionToCollections (20230324000000)
2025-08-12T13:30:21.351801658Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-08-12T13:30:21.351809754Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-08-12T13:30:21.351817861Z    -> 0.0061s
2025-08-12T13:30:21.351825837Z == 20230324000000 AddCollectionToCollections: migrated (0.0081s) ==============
2025-08-12T13:30:21.351833893Z 
2025-08-12T13:30:21.351841649Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-08-12T13:30:21.351866980Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-08-12T13:30:21.351875346Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0519s) =========
2025-08-12T13:30:21.351883483Z 
2025-08-12T13:30:21.351891289Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-08-12T13:30:21.351899395Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-08-12T13:30:21.351907511Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0068s) 
2025-08-12T13:30:21.351915688Z 
2025-08-12T13:30:21.351923453Z Migrating to AddSlugs (20230615135601)
2025-08-12T13:30:21.351931439Z == 20230615135601 AddSlugs: migrating =========================================
2025-08-12T13:30:21.351939626Z -- add_column(:models, :slug, :string)
2025-08-12T13:30:21.351947612Z    -> 0.0030s
2025-08-12T13:30:21.351955588Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-08-12T13:30:21.351963935Z    -> 0.0020s
2025-08-12T13:30:21.351971901Z -- add_column(:collections, :slug, :string)
2025-08-12T13:30:21.351980077Z    -> 0.0005s
2025-08-12T13:30:21.351997623Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-08-12T13:30:21.352006000Z    -> 0.0001s
2025-08-12T13:30:21.352014236Z -- add_column(:creators, :slug, :string)
2025-08-12T13:30:21.352022232Z    -> 0.0005s
2025-08-12T13:30:21.352032393Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-08-12T13:30:21.352040629Z    -> 0.0001s
2025-08-12T13:30:21.352048525Z == 20230615135601 AddSlugs: migrated (0.0067s) ================================
2025-08-12T13:30:21.352056682Z 
2025-08-12T13:30:21.352064447Z Migrating to GenerateSlugs (20230617222353)
2025-08-12T13:30:21.352072423Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-08-12T13:30:21.352080530Z == 20230617222353 GenerateSlugs: migrated (0.0543s) ===========================
2025-08-12T13:30:21.352088666Z 
2025-08-12T13:30:21.352096432Z Migrating to MakeNamesUnique (20230628194944)
2025-08-12T13:30:21.352104398Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-08-12T13:30:21.352112955Z == 20230628194944 MakeNamesUnique: migrated (0.0032s) =========================
2025-08-12T13:30:21.352121131Z 
2025-08-12T13:30:21.352129047Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-08-12T13:30:21.352137234Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-08-12T13:30:21.352145480Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-08-12T13:30:21.352153847Z    -> 0.0021s
2025-08-12T13:30:21.352161823Z -- remove_index(:creators, :slug)
2025-08-12T13:30:21.352169779Z    -> 0.0004s
2025-08-12T13:30:21.352177695Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-08-12T13:30:21.352185902Z    -> 0.0001s
2025-08-12T13:30:21.352193858Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-08-12T13:30:21.352202245Z    -> 0.0001s
2025-08-12T13:30:21.352210231Z -- remove_index(:collections, :slug)
2025-08-12T13:30:21.352218187Z    -> 0.0253s
2025-08-12T13:30:21.352226103Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-08-12T13:30:21.352234359Z    -> 0.0007s
2025-08-12T13:30:21.352242265Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0293s) ======
2025-08-12T13:30:21.352250402Z 
2025-08-12T13:30:21.352258157Z Migrating to AddSizeToModelFiles (20230707082403)
2025-08-12T13:30:21.352266123Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-08-12T13:30:21.352274270Z -- add_column(:model_files, :size, :integer)
2025-08-12T13:30:21.352291194Z    -> 0.0006s
2025-08-12T13:30:21.352299260Z == 20230707082403 AddSizeToModelFiles: migrated (0.0010s) =====================
2025-08-12T13:30:21.352307507Z 
2025-08-12T13:30:21.352315403Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-08-12T13:30:21.352323539Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-08-12T13:30:21.352331645Z -- change_column(:model_files, :size, :bigint)
2025-08-12T13:30:21.352339621Z    -> 0.0081s
2025-08-12T13:30:21.352347638Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0085s) ==================
2025-08-12T13:30:21.352355764Z 
2025-08-12T13:30:21.352363520Z Migrating to AddNoteToProblems (20230711111009)
2025-08-12T13:30:21.352371516Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-08-12T13:30:21.352379612Z -- add_column(:problems, :note, :string, {default: nil})
2025-08-12T13:30:21.352387668Z    -> 0.0012s
2025-08-12T13:30:21.352395584Z == 20230711111009 AddNoteToProblems: migrated (0.0022s) =======================
2025-08-12T13:30:21.352403711Z 
2025-08-12T13:30:21.352411566Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-08-12T13:30:21.352419582Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-08-12T13:30:21.352428861Z -- 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-08-12T13:30:21.352442549Z    -> 0.0008s
2025-08-12T13:30:21.352450535Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0009s) ================
2025-08-12T13:30:21.352458751Z 
2025-08-12T13:30:21.352466647Z Migrating to AddLicenseToModel (20240127143358)
2025-08-12T13:30:21.352474734Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-08-12T13:30:21.352482970Z -- add_column(:models, :license, :string)
2025-08-12T13:30:21.352490996Z    -> 0.0006s
2025-08-12T13:30:21.352498902Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-08-12T13:30:21.352506989Z 
2025-08-12T13:30:21.352514724Z Migrating to AddIgnoredToProblems (20240131134832)
2025-08-12T13:30:21.352522670Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-08-12T13:30:21.352530736Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-08-12T13:30:21.352538793Z    -> 0.0005s
2025-08-12T13:30:21.352546749Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-08-12T13:30:21.352563613Z 
2025-08-12T13:30:21.352571438Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-08-12T13:30:21.352579485Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-08-12T13:30:21.352587611Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-08-12T13:30:21.352595857Z    -> 0.0110s
2025-08-12T13:30:21.352603733Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0111s) ======
2025-08-12T13:30:21.352611840Z 
2025-08-12T13:30:21.352619826Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-08-12T13:30:21.352628032Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-08-12T13:30:21.352636269Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-08-12T13:30:21.352645027Z    -> 0.0007s
2025-08-12T13:30:21.352653163Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-08-12T13:30:21.352661279Z 
2025-08-12T13:30:21.352669145Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-08-12T13:30:21.352677161Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-08-12T13:30:21.352685328Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-08-12T13:30:21.352693624Z    -> 0.0002s
2025-08-12T13:30:21.352701580Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-08-12T13:30:21.352710007Z    -> 0.0010s
2025-08-12T13:30:21.352717973Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-08-12T13:30:21.352726370Z    -> 0.0001s
2025-08-12T13:30:21.352734397Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-08-12T13:30:21.352742934Z    -> 0.0044s
2025-08-12T13:30:21.836084564Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0059s) =================
2025-08-12T13:30:21.836119915Z 
2025-08-12T13:30:21.836129374Z Migrating to CreateFlipperTables (20240306095646)
2025-08-12T13:30:21.836137781Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-08-12T13:30:21.836146328Z -- create_table(:flipper_features)
2025-08-12T13:30:21.836154665Z    -> 0.0029s
2025-08-12T13:30:21.836163573Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-08-12T13:30:21.836172681Z    -> 0.0049s
2025-08-12T13:30:21.836180747Z -- create_table(:flipper_gates)
2025-08-12T13:30:21.836208072Z    -> 0.0003s
2025-08-12T13:30:21.836216449Z -- add_index(:flipper_gates, [:feature_key, :key, :value], {unique: true, length: {value: 255}, name: "index_flipper_gates_on_feature_key_and_key_and_value"})
2025-08-12T13:30:21.836225107Z    -> 0.0002s
2025-08-12T13:30:21.836235578Z == 20240306095646 CreateFlipperTables: migrated (0.0099s) =====================
2025-08-12T13:30:21.836243854Z 
2025-08-12T13:30:21.836251820Z Migrating to RolifyCreateRoles (20240319155251)
2025-08-12T13:30:21.836260017Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-08-12T13:30:21.836268153Z -- create_table(:roles)
2025-08-12T13:30:21.836276009Z    -> 0.0433s
2025-08-12T13:30:21.836283975Z -- create_table(:users_roles, {id: false})
2025-08-12T13:30:21.836291971Z    -> 0.0005s
2025-08-12T13:30:21.836299947Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-08-12T13:30:21.836308154Z    -> 0.0059s
2025-08-12T13:30:21.836316180Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-08-12T13:30:21.836324647Z    -> 0.0002s
2025-08-12T13:30:21.836332573Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-08-12T13:30:21.836340790Z    -> 0.0001s
2025-08-12T13:30:21.836348696Z == 20240319155251 RolifyCreateRoles: migrated (0.0672s) =======================
2025-08-12T13:30:21.836356722Z 
2025-08-12T13:30:21.836364517Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-08-12T13:30:21.836372764Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-08-12T13:30:21.836380850Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0102s) ==================
2025-08-12T13:30:21.836389027Z 
2025-08-12T13:30:21.836396822Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-08-12T13:30:21.836404799Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-08-12T13:30:21.836412855Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-08-12T13:30:21.836420921Z    -> 0.0254s
2025-08-12T13:30:21.836428727Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0268s) ====================
2025-08-12T13:30:21.836436653Z 
2025-08-12T13:30:21.836444448Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-08-12T13:30:21.836452655Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-08-12T13:30:21.836460761Z -- add_column(:users, :reset_password_token, :string)
2025-08-12T13:30:21.836468727Z    -> 0.0011s
2025-08-12T13:30:21.836476693Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-08-12T13:30:21.836496864Z    -> 0.0002s
2025-08-12T13:30:21.836505301Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0033s) ============
2025-08-12T13:30:21.836513467Z 
2025-08-12T13:30:21.836521293Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-08-12T13:30:21.836529470Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-08-12T13:30:21.836537556Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0269s) ==============
2025-08-12T13:30:21.836545582Z 
2025-08-12T13:30:21.836553358Z Migrating to AddRememberableToUsers (20240410221112)
2025-08-12T13:30:21.836561304Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-08-12T13:30:21.836569360Z -- add_column(:users, :remember_created_at, :datetime)
2025-08-12T13:30:21.836577366Z    -> 0.0038s
2025-08-12T13:30:21.836585312Z == 20240410221112 AddRememberableToUsers: migrated (0.0052s) ==================
2025-08-12T13:30:21.836593448Z 
2025-08-12T13:30:21.836601214Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-08-12T13:30:21.836609260Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-08-12T13:30:21.836617367Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-08-12T13:30:21.836625393Z    -> 0.0006s
2025-08-12T13:30:21.836633319Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0019s) ===========
2025-08-12T13:30:21.836641365Z 
2025-08-12T13:30:21.836649151Z Migrating to DropDelayedJobs (20240418112821)
2025-08-12T13:30:21.836657157Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-08-12T13:30:21.836665233Z -- drop_table(:delayed_jobs)
2025-08-12T13:30:21.836673159Z    -> 0.0020s
2025-08-12T13:30:21.836681055Z == 20240418112821 DropDelayedJobs: migrated (0.0127s) =========================
2025-08-12T13:30:21.836689121Z 
2025-08-12T13:30:21.836696857Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-08-12T13:30:21.836704853Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-08-12T13:30:21.836712939Z -- add_column(:users, :interface_language, :string)
2025-08-12T13:30:21.836720995Z    -> 0.0007s
2025-08-12T13:30:21.836728911Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0045s) =============
2025-08-12T13:30:21.836736977Z 
2025-08-12T13:30:21.836744763Z Migrating to AddLockableToUsers (20240610120318)
2025-08-12T13:30:21.836752699Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-08-12T13:30:21.836760785Z -- change_table(:users)
2025-08-12T13:30:21.836768661Z    -> 0.0018s
2025-08-12T13:30:21.836785355Z == 20240610120318 AddLockableToUsers: migrated (0.0021s) ======================
2025-08-12T13:30:21.836793581Z 
2025-08-12T13:30:21.836801497Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-08-12T13:30:21.836809534Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-08-12T13:30:21.836817610Z -- add_column(:model_files, :attachment_data, :json)
2025-08-12T13:30:21.836825917Z    -> 0.0006s
2025-08-12T13:30:21.836833873Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0010s) ===========
2025-08-12T13:30:21.836841979Z 
2025-08-12T13:30:21.836849815Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-08-12T13:30:21.836858302Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-08-12T13:30:21.836866438Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0144s) ==================
2025-08-12T13:30:21.836874605Z 
2025-08-12T13:30:21.836882420Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-08-12T13:30:21.836890477Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-08-12T13:30:21.836898583Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-08-12T13:30:21.836906900Z    -> 0.0007s
2025-08-12T13:30:21.836914926Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0027s) ============
2025-08-12T13:30:21.836923102Z 
2025-08-12T13:30:21.836931108Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-08-12T13:30:21.836939105Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-08-12T13:30:21.836947191Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-08-12T13:30:21.836955217Z    -> 0.0007s
2025-08-12T13:30:21.836963033Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-08-12T13:30:21.836970939Z    -> 0.0006s
2025-08-12T13:30:21.836978744Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-08-12T13:30:21.836986680Z    -> 0.0006s
2025-08-12T13:30:21.836994646Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-08-12T13:30:21.837002743Z    -> 0.0054s
2025-08-12T13:30:21.837010879Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-08-12T13:30:21.837018935Z    -> 0.0006s
2025-08-12T13:30:21.837026962Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0092s) ====================
2025-08-12T13:30:21.837034988Z 
2025-08-12T13:30:21.837042733Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-08-12T13:30:21.837050820Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-08-12T13:30:21.837067684Z -- remove_index(:libraries, :path)
2025-08-12T13:30:21.837075680Z    -> 0.0011s
2025-08-12T13:30:21.837083746Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0019s) ================
2025-08-12T13:30:21.837091992Z 
2025-08-12T13:30:21.837099748Z Migrating to CreateFederailsActors (20240727113215)
2025-08-12T13:30:21.837107714Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-08-12T13:30:21.837115760Z -- create_table(:federails_actors)
2025-08-12T13:30:21.837123736Z    -> 0.0008s
2025-08-12T13:30:21.837131672Z -- foreign_key_exists?(:federails_actors, :users)
2025-08-12T13:30:21.837139648Z    -> 0.0021s
2025-08-12T13:30:21.837147544Z -- remove_foreign_key(:federails_actors, :users)
2025-08-12T13:30:21.837155510Z    -> 0.0119s
2025-08-12T13:30:21.837163587Z -- remove_index(:federails_actors, :user_id)
2025-08-12T13:30:21.837171733Z    -> 0.0004s
2025-08-12T13:30:21.837179719Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-08-12T13:30:21.837188086Z    -> 0.0001s
2025-08-12T13:30:21.837196002Z -- add_foreign_key(:federails_actors, :users)
2025-08-12T13:30:21.837203948Z    -> 0.0104s
2025-08-12T13:30:21.837211954Z == 20240727113215 CreateFederailsActors: migrated (0.0267s) ===================
2025-08-12T13:30:21.837220050Z 
2025-08-12T13:30:21.837227746Z Migrating to CreateFederailsFollowings (20240727113216)
2025-08-12T13:30:21.837236133Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-08-12T13:30:21.837244289Z -- create_table(:federails_followings)
2025-08-12T13:30:21.837252195Z    -> 0.0014s
2025-08-12T13:30:21.837260111Z == 20240727113216 CreateFederailsFollowings: migrated (0.0015s) ===============
2025-08-12T13:30:21.837268247Z 
2025-08-12T13:30:21.837275993Z Migrating to CreateFederailsActivities (20240727113217)
2025-08-12T13:30:21.837284029Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-08-12T13:30:21.837292085Z -- create_table(:federails_activities)
2025-08-12T13:30:21.837300001Z    -> 0.0096s
2025-08-12T13:30:21.837307897Z == 20240727113217 CreateFederailsActivities: migrated (0.0097s) ===============
2025-08-12T13:30:21.837316054Z 
2025-08-12T13:30:21.837324731Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-08-12T13:30:21.837332817Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-08-12T13:30:21.837340894Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-08-12T13:30:21.837349160Z    -> 0.0112s
2025-08-12T13:30:21.837366465Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-08-12T13:30:21.837374562Z    -> 0.0004s
2025-08-12T13:30:21.837382498Z -- change_table(:federails_actors)
2025-08-12T13:30:21.837390504Z    -> 0.0065s
2025-08-12T13:30:21.837398450Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0181s) =======
2025-08-12T13:30:21.837406586Z 
2025-08-12T13:30:21.837414412Z Migrating to CreateFederailsActors (20240731165647)
2025-08-12T13:30:21.837422388Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-08-12T13:30:21.837430494Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-08-12T13:30:21.837438611Z 
2025-08-12T13:30:21.837446386Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-08-12T13:30:21.837454462Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-08-12T13:30:21.837462549Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-08-12T13:30:21.837470605Z 
2025-08-12T13:30:21.837478381Z Migrating to BackfillActivities (20240805111500)
2025-08-12T13:30:21.837486367Z == 20240805111500 BackfillActivities: migrating ===============================
2025-08-12T13:30:21.837494453Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-08-12T13:30:21.837502569Z 
2025-08-12T13:30:21.837510455Z Migrating to CreateCaberRelations (20240827155630)
2025-08-12T13:30:21.837518471Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-08-12T13:30:21.837526578Z -- create_table(:caber_relations)
2025-08-12T13:30:21.837534534Z    -> 0.0418s
2025-08-12T13:30:21.837542400Z == 20240827155630 CreateCaberRelations: migrated (0.0418s) ====================
2025-08-12T13:30:21.837550516Z 
2025-08-12T13:30:21.837558292Z Migrating to AddDefaultAccessControls (20240830121749)
2025-08-12T13:30:21.837566258Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-08-12T13:30:21.837574294Z == 20240830121749 AddDefaultAccessControls: migrated (0.0235s) ================
2025-08-12T13:30:21.837582420Z 
2025-08-12T13:30:21.837590687Z Migrating to RenameDefaultRoles (20240830151650)
2025-08-12T13:30:22.505750734Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-08-12T13:30:22.505785244Z == 20240830151650 RenameDefaultRoles: migrated (0.0440s) ======================
2025-08-12T13:30:22.505797699Z 
2025-08-12T13:30:22.505805805Z Migrating to AddPublicIDsToModels (20240904151944)
2025-08-12T13:30:22.505813901Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-08-12T13:30:22.505839483Z -- add_column(:models, :public_id, :string)
2025-08-12T13:30:22.505847690Z    -> 0.0008s
2025-08-12T13:30:22.505856086Z -- add_index(:models, :public_id)
2025-08-12T13:30:22.505864042Z    -> 0.0027s
2025-08-12T13:30:22.505871948Z -- add_column(:model_files, :public_id, :string)
2025-08-12T13:30:22.505879864Z    -> 0.0007s
2025-08-12T13:30:22.505887700Z -- add_index(:model_files, :public_id)
2025-08-12T13:30:22.505895586Z    -> 0.0001s
2025-08-12T13:30:22.505903582Z -- add_column(:problems, :public_id, :string)
2025-08-12T13:30:22.505911468Z    -> 0.0007s
2025-08-12T13:30:22.505919284Z -- add_index(:problems, :public_id)
2025-08-12T13:30:22.505927130Z    -> 0.0001s
2025-08-12T13:30:22.505935005Z -- add_column(:creators, :public_id, :string)
2025-08-12T13:30:22.505942901Z    -> 0.0007s
2025-08-12T13:30:22.505950737Z -- add_index(:creators, :public_id)
2025-08-12T13:30:22.505958533Z    -> 0.0001s
2025-08-12T13:30:22.505966419Z -- add_column(:collections, :public_id, :string)
2025-08-12T13:30:22.505974335Z    -> 0.0006s
2025-08-12T13:30:22.505982140Z -- add_index(:collections, :public_id)
2025-08-12T13:30:22.505990237Z    -> 0.0001s
2025-08-12T13:30:22.505998122Z -- add_column(:libraries, :public_id, :string)
2025-08-12T13:30:22.506006018Z    -> 0.0006s
2025-08-12T13:30:22.506013794Z -- add_index(:libraries, :public_id)
2025-08-12T13:30:22.506021630Z    -> 0.0001s
2025-08-12T13:30:22.506029556Z == 20240904151944 AddPublicIDsToModels: migrated (0.0076s) ====================
2025-08-12T13:30:22.506037642Z 
2025-08-12T13:30:22.506045297Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-08-12T13:30:22.506053193Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-08-12T13:30:22.506061179Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:22.506069206Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0368s) ==============
2025-08-12T13:30:22.506077212Z 
2025-08-12T13:30:22.506084987Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-08-12T13:30:22.506092974Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-08-12T13:30:22.506100930Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-08-12T13:30:22.506108906Z 
2025-08-12T13:30:22.506116541Z Migrating to DeduplicateRoles (20240923114515)
2025-08-12T13:30:22.506124387Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-08-12T13:30:22.506132333Z == 20240923114515 DeduplicateRoles: migrated (0.1482s) ========================
2025-08-12T13:30:22.506149417Z 
2025-08-12T13:30:22.506157183Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-08-12T13:30:22.506165249Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-08-12T13:30:22.506173185Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-08-12T13:30:22.506181522Z    -> 0.1662s
2025-08-12T13:30:22.506190550Z -- add_index(:models, :name_lower)
2025-08-12T13:30:22.506198656Z    -> 0.0002s
2025-08-12T13:30:22.506206672Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-08-12T13:30:22.506214929Z    -> 0.0067s
2025-08-12T13:30:22.506222775Z -- add_index(:creators, :name_lower)
2025-08-12T13:30:22.506230731Z    -> 0.0001s
2025-08-12T13:30:22.506238557Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-08-12T13:30:22.506246803Z    -> 0.0085s
2025-08-12T13:30:22.506254629Z -- add_index(:collections, :name_lower)
2025-08-12T13:30:22.506262505Z    -> 0.0001s
2025-08-12T13:30:22.506270351Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1820s) =============
2025-08-12T13:30:22.506278407Z 
2025-08-12T13:30:22.506286082Z Migrating to AddKeypairToActors (20240926162407)
2025-08-12T13:30:22.506294008Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-08-12T13:30:22.506301974Z -- change_table(:federails_actors)
2025-08-12T13:30:22.506309850Z    -> 0.0015s
2025-08-12T13:30:22.506317686Z == 20240926162407 AddKeypairToActors: migrated (0.0015s) ======================
2025-08-12T13:30:22.506325732Z 
2025-08-12T13:30:22.506333398Z Migrating to AddUuids (20241004194445)
2025-08-12T13:30:22.506341213Z == 20241004194445 AddUuids: migrating =========================================
2025-08-12T13:30:22.506349220Z -- change_table(:federails_actors)
2025-08-12T13:30:22.506357136Z    -> 0.0032s
2025-08-12T13:30:22.506364991Z -- change_table(:federails_activities)
2025-08-12T13:30:22.506372817Z    -> 0.0009s
2025-08-12T13:30:22.506380643Z -- change_table(:federails_followings)
2025-08-12T13:30:22.506388519Z    -> 0.0008s
2025-08-12T13:30:22.506396344Z == 20241004194445 AddUuids: migrated (0.0050s) ================================
2025-08-12T13:30:22.506404331Z 
2025-08-12T13:30:22.506412006Z Migrating to CreateComments (20241007182824)
2025-08-12T13:30:22.506419932Z == 20241007182824 CreateComments: migrating ===================================
2025-08-12T13:30:22.506427878Z -- create_table(:comments)
2025-08-12T13:30:22.506444532Z    -> 0.0028s
2025-08-12T13:30:22.506452468Z == 20241007182824 CreateComments: migrated (0.0029s) ==========================
2025-08-12T13:30:22.506460494Z 
2025-08-12T13:30:22.506468309Z Migrating to AddSystemToComments (20241009122540)
2025-08-12T13:30:22.506476215Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-08-12T13:30:22.506484272Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-08-12T13:30:22.506492308Z    -> 0.0009s
2025-08-12T13:30:22.506500144Z == 20241009122540 AddSystemToComments: migrated (0.0009s) =====================
2025-08-12T13:30:22.506508110Z 
2025-08-12T13:30:22.506515805Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-08-12T13:30:22.506523711Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-08-12T13:30:22.506531647Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0016s) ============
2025-08-12T13:30:22.506539563Z 
2025-08-12T13:30:22.506547218Z Migrating to AddOmniauthToUsers (20241015090803)
2025-08-12T13:30:22.506555134Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-08-12T13:30:22.506563180Z -- add_column(:users, :auth_provider, :string)
2025-08-12T13:30:22.506571076Z    -> 0.0008s
2025-08-12T13:30:22.506578932Z -- add_column(:users, :auth_uid, :string)
2025-08-12T13:30:22.506587279Z    -> 0.0007s
2025-08-12T13:30:22.506595145Z == 20241015090803 AddOmniauthToUsers: migrated (0.0016s) ======================
2025-08-12T13:30:22.506603161Z 
2025-08-12T13:30:22.506610836Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-08-12T13:30:22.506618873Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-08-12T13:30:22.506626839Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-08-12T13:30:22.506634845Z    -> 0.0008s
2025-08-12T13:30:22.506642721Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-08-12T13:30:22.506650717Z    -> 0.0007s
2025-08-12T13:30:22.506658533Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0016s) =====
2025-08-12T13:30:22.506666479Z 
2025-08-12T13:30:22.506675326Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-08-12T13:30:22.506683423Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-08-12T13:30:22.506691439Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-08-12T13:30:22.506699465Z    -> 0.0008s
2025-08-12T13:30:22.506707301Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-08-12T13:30:22.506723984Z 
2025-08-12T13:30:22.506731820Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-08-12T13:30:22.506739786Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-08-12T13:30:22.506747842Z -- change_table(:users)
2025-08-12T13:30:22.506755748Z    -> 0.0010s
2025-08-12T13:30:22.506763574Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-08-12T13:30:22.506771600Z 
2025-08-12T13:30:22.506779376Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-08-12T13:30:22.506787302Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-08-12T13:30:22.506795298Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0065s) =================
2025-08-12T13:30:22.506803364Z 
2025-08-12T13:30:22.506811180Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-08-12T13:30:22.506819196Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-08-12T13:30:22.506827242Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-08-12T13:30:22.506835619Z    -> 0.0009s
2025-08-12T13:30:22.506843435Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-08-12T13:30:22.506851802Z    -> 0.0013s
2025-08-12T13:30:22.506859638Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-08-12T13:30:22.506867734Z    -> 0.0006s
2025-08-12T13:30:22.506875570Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-08-12T13:30:22.506883886Z    -> 0.0020s
2025-08-12T13:30:22.506891752Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-08-12T13:30:22.506899929Z    -> 0.0008s
2025-08-12T13:30:22.506907714Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-08-12T13:30:22.506915901Z    -> 0.0008s
2025-08-12T13:30:22.506924218Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-08-12T13:30:22.506932564Z    -> 0.0005s
2025-08-12T13:30:22.506940360Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0069s) ===================
2025-08-12T13:30:22.506948406Z 
2025-08-12T13:30:22.506956092Z Migrating to AddInProgressToProblems (20241105121830)
2025-08-12T13:30:22.506964108Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-08-12T13:30:22.506972084Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-08-12T13:30:22.506980100Z    -> 0.0008s
2025-08-12T13:30:22.506987946Z == 20241105121830 AddInProgressToProblems: migrated (0.0009s) =================
2025-08-12T13:30:22.507004720Z 
2025-08-12T13:30:22.507012856Z Migrating to ClearStuckProblems (20241118155027)
2025-08-12T13:30:22.507020832Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-08-12T13:30:22.507028858Z == 20241118155027 ClearStuckProblems: migrated (0.0284s) ======================
2025-08-12T13:30:22.507037045Z 
2025-08-12T13:30:22.507044800Z Migrating to AddApprovedToUser (20241122121621)
2025-08-12T13:30:22.507053007Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-08-12T13:30:22.507061224Z -- change_table(:users)
2025-08-12T13:30:22.507069029Z    -> 0.0015s
2025-08-12T13:30:22.507076855Z == 20241122121621 AddApprovedToUser: migrated (0.0015s) =======================
2025-08-12T13:30:22.507084861Z 
2025-08-12T13:30:22.507092567Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-08-12T13:30:22.507100523Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-08-12T13:30:22.507108489Z -- create_table(:federails_moderation_reports)
2025-08-12T13:30:22.507116334Z    -> 0.0030s
2025-08-12T13:30:22.507124230Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0031s) ========
2025-08-12T13:30:22.507132226Z 
2025-08-12T13:30:22.507139862Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-08-12T13:30:22.507147888Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-08-12T13:30:22.507155874Z -- create_table(:federails_moderation_domain_blocks)
2025-08-12T13:30:22.507163780Z    -> 0.0005s
2025-08-12T13:30:22.507171606Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-08-12T13:30:22.507179582Z 
2025-08-12T13:30:22.507187237Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-08-12T13:30:22.507195153Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-08-12T13:30:22.507203149Z -- change_column_null(:comments, :commenter_id, true)
2025-08-12T13:30:22.507211165Z    -> 0.0078s
2025-08-12T13:30:22.507219001Z -- change_column_null(:comments, :commenter_type, true)
2025-08-12T13:30:22.507226927Z    -> 0.0077s
2025-08-12T13:30:22.507234713Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-08-12T13:30:22.507242699Z    -> 0.0008s
2025-08-12T13:30:22.507250475Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-08-12T13:30:22.507258471Z    -> 0.0108s
2025-08-12T13:30:23.435720351Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0286s) =======
2025-08-12T13:30:23.435758328Z 
2025-08-12T13:30:23.435790402Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-08-12T13:30:23.435798849Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-08-12T13:30:23.435806936Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-08-12T13:30:23.435815022Z    -> 0.0009s
2025-08-12T13:30:23.435823329Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0009s) =================
2025-08-12T13:30:23.435835313Z 
2025-08-12T13:30:23.435843479Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-08-12T13:30:23.435874552Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-08-12T13:30:23.435886436Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1731s) ==================
2025-08-12T13:30:23.435896727Z 
2025-08-12T13:30:23.435906556Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-08-12T13:30:23.435916436Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-08-12T13:30:23.435925745Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-08-12T13:30:23.435933861Z    -> 0.0018s
2025-08-12T13:30:23.435941837Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0019s) ==========
2025-08-12T13:30:23.435949793Z 
2025-08-12T13:30:23.435957469Z Migrating to AddCreatorToCollections (20250222000000)
2025-08-12T13:30:23.435965385Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-08-12T13:30:23.435973341Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-08-12T13:30:23.435981317Z    -> 0.0241s
2025-08-12T13:30:23.435989113Z == 20250222000000 AddCreatorToCollections: migrated (0.0241s) =================
2025-08-12T13:30:23.435997059Z 
2025-08-12T13:30:23.436004844Z Migrating to AddLocalToActors (20250305171530)
2025-08-12T13:30:23.436012700Z == 20250305171530 AddLocalToActors: migrating =================================
2025-08-12T13:30:23.436020716Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-08-12T13:30:23.436030195Z    -> 0.0009s
2025-08-12T13:30:23.436039945Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-08-12T13:30:23.436050526Z    -> 0.0019s
2025-08-12T13:30:23.436059645Z    -> 0 rows
2025-08-12T13:30:23.436067591Z == 20250305171530 AddLocalToActors: migrated (0.0061s) ========================
2025-08-12T13:30:23.436075697Z 
2025-08-12T13:30:23.436083372Z Migrating to AddActorTypeToActors (20250407160721)
2025-08-12T13:30:23.436091228Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-08-12T13:30:23.436110517Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-08-12T13:30:23.436120638Z    -> 0.0008s
2025-08-12T13:30:23.436130147Z == 20250407160721 AddActorTypeToActors: migrated (0.0009s) ====================
2025-08-12T13:30:23.436140157Z 
2025-08-12T13:30:23.436148243Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-08-12T13:30:23.436156440Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-08-12T13:30:23.436166019Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-08-12T13:30:23.436174205Z    -> 0.0022s
2025-08-12T13:30:23.436182011Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0022s) =================
2025-08-12T13:30:23.436190017Z 
2025-08-12T13:30:23.436197723Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-08-12T13:30:23.436206721Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-08-12T13:30:23.436216801Z -- create_table(:oauth_applications)
2025-08-12T13:30:23.436226300Z    -> 0.0010s
2025-08-12T13:30:23.436234286Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-08-12T13:30:23.436242293Z    -> 0.0002s
2025-08-12T13:30:23.436250108Z -- create_table(:oauth_access_grants)
2025-08-12T13:30:23.436257984Z    -> 0.0012s
2025-08-12T13:30:23.436265840Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-08-12T13:30:23.436273876Z    -> 0.0001s
2025-08-12T13:30:23.436281722Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-08-12T13:30:23.436291061Z    -> 0.0171s
2025-08-12T13:30:23.436301061Z -- create_table(:oauth_access_tokens)
2025-08-12T13:30:23.436310219Z    -> 0.0012s
2025-08-12T13:30:23.436318065Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-08-12T13:30:23.436326051Z    -> 0.0006s
2025-08-12T13:30:23.436334268Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-08-12T13:30:23.436342294Z    -> 0.0001s
2025-08-12T13:30:23.436350220Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-08-12T13:30:23.436358406Z    -> 0.0230s
2025-08-12T13:30:23.436366302Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-08-12T13:30:23.436376313Z    -> 0.0153s
2025-08-12T13:30:23.436386323Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-08-12T13:30:23.436395110Z    -> 0.0127s
2025-08-12T13:30:23.436403026Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0729s) ==================
2025-08-12T13:30:23.436411052Z 
2025-08-12T13:30:23.436428488Z Migrating to AddOwnerToApplication (20250408145956)
2025-08-12T13:30:23.436436554Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-08-12T13:30:23.436444520Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-08-12T13:30:23.436453418Z    -> 0.0011s
2025-08-12T13:30:23.436463368Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-08-12T13:30:23.436473358Z    -> 0.0009s
2025-08-12T13:30:23.436481424Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-08-12T13:30:23.436489410Z    -> 0.0002s
2025-08-12T13:30:23.436497256Z == 20250408145956 AddOwnerToApplication: migrated (0.0075s) ===================
2025-08-12T13:30:23.436505282Z 
2025-08-12T13:30:23.436512918Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-08-12T13:30:23.436520753Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-08-12T13:30:23.436528719Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-08-12T13:30:23.436537808Z    -> 0.0248s
2025-08-12T13:30:23.436547798Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0264s) ============
2025-08-12T13:30:23.436557147Z 
2025-08-12T13:30:23.436564902Z Migrating to AddQuotaToUsers (20250409125753)
2025-08-12T13:30:23.436573500Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-08-12T13:30:23.436581546Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-08-12T13:30:23.436589522Z    -> 0.0012s
2025-08-12T13:30:23.436597298Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-08-12T13:30:23.436605314Z    -> 0.0009s
2025-08-12T13:30:23.436613059Z == 20250409125753 AddQuotaToUsers: migrated (0.0036s) =========================
2025-08-12T13:30:23.436622779Z 
2025-08-12T13:30:23.436632529Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-08-12T13:30:23.436641677Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-08-12T13:30:23.436649783Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-08-12T13:30:23.436658200Z    -> 0.0135s
2025-08-12T13:30:23.436666086Z -- add_index(:model_files, :filename_lower)
2025-08-12T13:30:23.436674022Z    -> 0.0002s
2025-08-12T13:30:23.436681818Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0152s) 
2025-08-12T13:30:23.436689874Z 
2025-08-12T13:30:23.436698091Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-08-12T13:30:23.436708051Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-08-12T13:30:23.436728692Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-08-12T13:30:23.436736859Z    -> 0.0002s
2025-08-12T13:30:23.436744664Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0012s) ===================
2025-08-12T13:30:23.436752701Z 
2025-08-12T13:30:23.436760386Z Migrating to AddPreviewToModelFile (20250520111046)
2025-08-12T13:30:23.436768482Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-08-12T13:30:23.436776438Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-08-12T13:30:23.436785797Z    -> 0.0011s
2025-08-12T13:30:23.436795817Z == 20250520111046 AddPreviewToModelFile: migrated (0.0020s) ===================
2025-08-12T13:30:23.436805126Z 
2025-08-12T13:30:23.436812882Z Migrating to CreateAltchaSolutions (20250609210440)
2025-08-12T13:30:23.436820848Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-08-12T13:30:23.436828864Z -- create_table(:altcha_solutions)
2025-08-12T13:30:23.436836760Z    -> 0.0004s
2025-08-12T13:30:23.436844716Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-08-12T13:30:23.436853263Z    -> 0.0002s
2025-08-12T13:30:23.436861099Z == 20250609210440 CreateAltchaSolutions: migrated (0.0018s) ===================
2025-08-12T13:30:23.436871139Z 
2025-08-12T13:30:23.436880859Z Migrating to AddIndexableFields (20250620141805)
2025-08-12T13:30:23.436889707Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-08-12T13:30:23.436897773Z -- change_table(:models)
2025-08-12T13:30:23.436905649Z    -> 0.0025s
2025-08-12T13:30:23.436913484Z -- change_table(:creators)
2025-08-12T13:30:23.436921601Z    -> 0.0017s
2025-08-12T13:30:23.436929537Z -- change_table(:collections)
2025-08-12T13:30:23.436937503Z    -> 0.0017s
2025-08-12T13:30:23.436945960Z == 20250620141805 AddIndexableFields: migrated (0.0060s) ======================
2025-08-12T13:30:23.436956351Z 
2025-08-12T13:30:23.436966722Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-08-12T13:30:23.436975078Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-08-12T13:30:23.436983265Z -- change_column(:models, :indexable, :string)
2025-08-12T13:30:23.436991411Z    -> 0.0258s
2025-08-12T13:30:23.436999377Z -- change_column(:models, :ai_indexable, :string)
2025-08-12T13:30:23.437007454Z    -> 0.0181s
2025-08-12T13:30:23.437015430Z -- change_column(:creators, :indexable, :string)
2025-08-12T13:30:23.437023526Z    -> 0.0097s
2025-08-12T13:30:23.437044107Z -- change_column(:creators, :ai_indexable, :string)
2025-08-12T13:30:23.437053687Z    -> 0.0093s
2025-08-12T13:30:23.437061723Z -- change_column(:collections, :indexable, :string)
2025-08-12T13:30:23.437069889Z    -> 0.0545s
2025-08-12T13:30:23.437077876Z -- change_column(:collections, :ai_indexable, :string)
2025-08-12T13:30:23.437086022Z    -> 0.0181s
2025-08-12T13:30:23.437095822Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1359s) ======
2025-08-12T13:30:23.437103958Z 
2025-08-12T13:30:23.437112335Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-08-12T13:30:23.437122525Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-08-12T13:30:23.437132816Z -- change_table(:models)
2025-08-12T13:30:23.437140963Z    -> 0.0003s
2025-08-12T13:30:23.437148949Z -- change_table(:creators)
2025-08-12T13:30:23.437156855Z    -> 0.0003s
2025-08-12T13:30:23.437164771Z -- change_table(:collections)
2025-08-12T13:30:23.437172686Z    -> 0.0003s
2025-08-12T13:30:23.437180642Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0010s) =================
2025-08-12T13:30:23.437188739Z 
2025-08-12T13:30:23.437197496Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-08-12T13:30:23.437207707Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-08-12T13:30:23.437217497Z -- change_table(:links)
2025-08-12T13:30:23.437225483Z    -> 0.0003s
2025-08-12T13:30:23.437233519Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0004s) =======================
2025-08-12T13:30:23.437241645Z 
2025-08-12T13:30:23.437249461Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-08-12T13:30:23.437257537Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-08-12T13:30:23.437265654Z -- add_column(:links, :synced_at, :datetime)
2025-08-12T13:30:23.437273720Z    -> 0.0012s
2025-08-12T13:30:23.437282949Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0012s) ======================
2025-08-12T13:30:23.437293169Z 
2025-08-12T13:30:23.437302087Z Migrating to CreateFaspClientProviders (20250806142734)
2025-08-12T13:30:23.437310294Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-08-12T13:30:23.437318370Z -- create_table(:fasp_client_providers)
2025-08-12T13:30:23.437326396Z    -> 0.0479s
2025-08-12T13:30:23.437334332Z == 20250806142734 CreateFaspClientProviders: migrated (0.0479s) ===============
2025-08-12T13:30:23.437342498Z 
2025-08-12T13:30:23.499061261Z s6-rc: info: service init-manyfold-config successfully started
2025-08-12T13:30:23.499386236Z s6-rc: info: service init-config-end: starting
2025-08-12T13:30:23.501526967Z s6-rc: info: service init-config-end successfully started
2025-08-12T13:30:23.501746570Z s6-rc: info: service init-mods: starting
2025-08-12T13:30:23.503909656Z s6-rc: info: service init-mods successfully started
2025-08-12T13:30:23.504111132Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-08-12T13:30:23.513746407Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-08-12T13:30:23.513932973Z s6-rc: info: service init-mods-package-install: starting
2025-08-12T13:30:23.525438776Z [pkg-install-init] **** Installing all mod packages ****
2025-08-12T13:30:23.532675110Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-08-12T13:30:23.604450246Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-08-12T13:30:23.916717409Z (1/1) Installing redis (8.0.3-r0)
2025-08-12T13:30:23.926325009Z Executing redis-8.0.3-r0.pre-install
2025-08-12T13:30:23.967607683Z Executing redis-8.0.3-r0.post-install
2025-08-12T13:30:23.976856200Z Executing busybox-1.37.0-r19.trigger
2025-08-12T13:30:23.991201722Z OK: 427 MiB in 116 packages
2025-08-12T13:30:24.078109125Z s6-rc: info: service init-mods-package-install successfully started
2025-08-12T13:30:24.078357124Z s6-rc: info: service init-mods-end: starting
2025-08-12T13:30:24.080680885Z s6-rc: info: service init-mods-end successfully started
2025-08-12T13:30:24.080956890Z s6-rc: info: service init-custom-files: starting
2025-08-12T13:30:24.088019284Z [custom-init] No custom files found, skipping...
2025-08-12T13:30:24.088677730Z s6-rc: info: service init-custom-files successfully started
2025-08-12T13:30:24.088916992Z s6-rc: info: service init-services: starting
2025-08-12T13:30:24.090684402Z s6-rc: info: service init-services successfully started
2025-08-12T13:30:24.090834654Z s6-rc: info: service svc-mod-universal-redis: starting
2025-08-12T13:30:24.091174659Z s6-rc: info: service svc-manyfold: starting
2025-08-12T13:30:24.091592250Z s6-rc: info: service svc-cron: starting
2025-08-12T13:30:24.093987113Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-08-12T13:30:24.094255173Z s6-rc: info: service svc-cron successfully started
2025-08-12T13:30:24.109434525Z 281:C 12 Aug 2025 13:30:24.109 # WARNING Memory overcommit must be enabled! Without it, a background save or replication may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
2025-08-12T13:30:24.109453713Z 281:C 12 Aug 2025 13:30:24.109 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-08-12T13:30:24.109461088Z 281:C 12 Aug 2025 13:30:24.109 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=281, just started
2025-08-12T13:30:24.109488273Z 281:C 12 Aug 2025 13:30:24.109 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-08-12T13:30:24.110567567Z 281:M 12 Aug 2025 13:30:24.110 * monotonic clock: POSIX clock_gettime
2025-08-12T13:30:24.111272226Z 281:M 12 Aug 2025 13:30:24.111 * Running mode=standalone, port=6379.
2025-08-12T13:30:24.111705348Z 281:M 12 Aug 2025 13:30:24.111 * Server initialized
2025-08-12T13:30:24.111756351Z 281:M 12 Aug 2025 13:30:24.111 * Ready to accept connections tcp
2025-08-12T13:30:24.275196914Z 13:30:24 rails.1              | started with pid 301
2025-08-12T13:30:24.275232706Z 13:30:24 default_worker.1     | started with pid 302
2025-08-12T13:30:24.275279430Z 13:30:24 performance_worker.1 | started with pid 303
2025-08-12T13:30:25.513596304Z 13:30:25 rails.1              | `/root` is not writable.
2025-08-12T13:30:25.513697217Z 13:30:25 rails.1              | Bundler will use `/tmp/bundler20250812-301-6vxpmk301' as your home directory temporarily.
2025-08-12T13:30:26.005173860Z 13:30:26 default_worker.1     | `/root` is not writable.
2025-08-12T13:30:26.005210905Z 13:30:26 default_worker.1     | Bundler will use `/tmp/bundler20250812-302-2bzn2h302' as your home directory temporarily.
2025-08-12T13:30:26.011522527Z 13:30:26 performance_worker.1 | `/root` is not writable.
2025-08-12T13:30:26.011564912Z 13:30:26 performance_worker.1 | Bundler will use `/tmp/bundler20250812-303-zxatnj303' as your home directory temporarily.
2025-08-12T13:30:26.548894414Z 13:30:26 rails.1              | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-08-12T13:30:26.548936920Z 13:30:26 rails.1              | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-12T13:30:26.548946649Z 13:30:26 rails.1              | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-12T13:30:26.834449026Z 13:30:26 rails.1              | => Booting Puma
2025-08-12T13:30:26.834474828Z 13:30:26 rails.1              | => Rails 8.0.2 application starting in production 
2025-08-12T13:30:26.834487674Z 13:30:26 rails.1              | => Run `bin/rails server --help` for more startup options
2025-08-12T13:30:27.005022494Z 13:30:27 performance_worker.1 | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-08-12T13:30:27.005063988Z 13:30:27 performance_worker.1 | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-12T13:30:27.005079529Z 13:30:27 performance_worker.1 | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-12T13:30:27.013260616Z 13:30:27 default_worker.1     | /app/www/vendor/bundle/ruby/3.4.0/gems/rswag-ui-2.16.0/lib/rswag/ui/configuration.rb:1: warning: /usr/lib/ruby/3.4.0/ostruct.rb was loaded from the standard library, but will no longer be part of the default gems starting from Ruby 3.5.0.
2025-08-12T13:30:27.013310266Z 13:30:27 default_worker.1     | You can add ostruct to your Gemfile or gemspec to silence this warning.
2025-08-12T13:30:27.013422983Z 13:30:27 default_worker.1     | Also please contact the author of rswag-ui-2.16.0 to request adding ostruct into its gemspec.
2025-08-12T13:30:27.467950530Z 13:30:27 default_worker.1     | Server: cfa63cddd513, Context: rails, Role: web, data: {cpu: {one_min: 4.05, five_min: 2.43, fifteen_min: 2.18}, memory: 0.180371456e9, disk: {available: 852887584768, total: 938656133120, used: 85768548352}}
2025-08-12T13:30:27.512420524Z 13:30:27 performance_worker.1 | Server: cfa63cddd513, Context: rails, Role: web, data: {cpu: {one_min: 4.05, five_min: 2.43, fifteen_min: 2.18}, memory: 0.184909824e9, disk: {available: 852887457792, total: 938656133120, used: 85768675328}}
2025-08-12T13:30:29.767365353Z 13:30:29 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:29.769561186Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.769Z pid=302 tid=22e: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-12T13:30:29.774664143Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.774Z pid=302 tid=22e: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-08-12T13:30:29.776529440Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.776Z pid=302 tid=22e: Cron Jobs - added job with name clear-downloads in the namespace default
2025-08-12T13:30:29.831525113Z 13:30:29 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:29.833151849Z 13:30:29 performance_worker.1 | INFO  2025-08-12T13:30:29.832Z pid=303 tid=22f: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-12T13:30:29.859544855Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.859Z pid=302 tid=22e: Booted Rails 8.0.2 application in production environment
2025-08-12T13:30:29.859839668Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.859Z pid=302 tid=22e: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-08-12T13:30:29.859882915Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.859Z pid=302 tid=22e: See LICENSE and the LGPL-3.0 for licensing details.
2025-08-12T13:30:29.859888597Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.859Z pid=302 tid=22e: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-08-12T13:30:29.862387460Z 13:30:29 default_worker.1     | INFO  2025-08-12T13:30:29.862Z pid=302 tid=22e: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-08-12T13:30:29.904852445Z 13:30:29 performance_worker.1 | INFO  2025-08-12T13:30:29.904Z pid=303 tid=22f: Booted Rails 8.0.2 application in production environment
2025-08-12T13:30:29.904908528Z 13:30:29 performance_worker.1 | INFO  2025-08-12T13:30:29.904Z pid=303 tid=22f: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-08-12T13:30:29.904923749Z 13:30:29 performance_worker.1 | INFO  2025-08-12T13:30:29.904Z pid=303 tid=22f: See LICENSE and the LGPL-3.0 for licensing details.
2025-08-12T13:30:29.904964030Z 13:30:29 performance_worker.1 | INFO  2025-08-12T13:30:29.904Z pid=303 tid=22f: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-08-12T13:30:29.907418062Z 13:30:29 performance_worker.1 | INFO  2025-08-12T13:30:29.907Z pid=303 tid=22f: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-08-12T13:30:29.977045443Z 13:30:29 rails.1              | Server: cfa63cddd513, Context: rails, Role: web, data: {cpu: {one_min: 4.05, five_min: 2.43, fifteen_min: 2.18}, memory: 0.173645824e9, disk: {available: 852888760320, total: 938656133120, used: 85767372800}}
2025-08-12T13:30:29.977156707Z 13:30:29 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:29.977182790Z 13:30:29 rails.1              | INFO  2025-08-12T13:30:29.769Z pid=301 tid=2cl: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-08-12T13:30:29.977189654Z 13:30:29 rails.1              | INFO  2025-08-12T13:30:29.776Z pid=301 tid=2cl: Cron Jobs - added job with name clear-downloads in the namespace default
2025-08-12T13:30:29.977249695Z 13:30:29 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 36671ff7-5a29-447f-a725-a2718becb5f3) to Sidekiq(upgrade)
2025-08-12T13:30:29.977301719Z 13:30:29 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 5f05b895-f421-4cc8-9c7a-0898de601d96) to Sidekiq(upgrade)
2025-08-12T13:30:29.977331670Z 13:30:29 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 9c2c78fa-9058-42d2-a128-a42cc41d1017) to Sidekiq(upgrade)
2025-08-12T13:30:29.977355017Z 13:30:29 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: d75c5ce8-8f87-404c-96e3-a5d170555760) to Sidekiq(upgrade)
2025-08-12T13:30:29.977386079Z 13:30:29 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 996e998a-1427-4cfa-9139-7bf7ca23c98a) to Sidekiq(upgrade)
2025-08-12T13:30:29.977431952Z 13:30:29 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27) to Sidekiq(upgrade)
2025-08-12T13:30:29.977451922Z 13:30:29 rails.1              | [301] Puma starting in cluster mode...
2025-08-12T13:30:29.977519508Z 13:30:29 rails.1              | [301] * Puma version: 6.6.1 ("Return to Forever")
2025-08-12T13:30:29.977533125Z 13:30:29 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-08-12T13:30:29.977577635Z 13:30:29 rails.1              | [301] *  Min threads: 4
2025-08-12T13:30:29.977592395Z 13:30:29 rails.1              | [301] *  Max threads: 16
2025-08-12T13:30:29.977619199Z 13:30:29 rails.1              | [301] *  Environment: production
2025-08-12T13:30:29.977645412Z 13:30:29 rails.1              | [301] *   Master PID: 301
2025-08-12T13:30:29.977670933Z 13:30:29 rails.1              | [301] *      Workers: 4
2025-08-12T13:30:29.977704390Z 13:30:29 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-08-12T13:30:29.977741465Z 13:30:29 rails.1              | [301] * Preloading application
2025-08-12T13:30:29.977761616Z 13:30:29 rails.1              | [301] * Listening on http://[::]:3214
2025-08-12T13:30:29.977790774Z 13:30:29 rails.1              | [301] Use Ctrl-C to stop
2025-08-12T13:30:30.006986986Z 13:30:30 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.03s, phase: 0
2025-08-12T13:30:30.007096607Z 13:30:30 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.02s, phase: 0
2025-08-12T13:30:30.007143551Z 13:30:30 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-08-12T13:30:30.008938557Z 13:30:30 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-08-12T13:30:30.126606983Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-08-12T13:30:30.128026792Z s6-rc: info: service svc-manyfold successfully started
2025-08-12T13:30:30.128149950Z s6-rc: info: service legacy-services: starting
2025-08-12T13:30:30.135892333Z s6-rc: info: service legacy-services successfully started
2025-08-12T13:30:30.135964669Z s6-rc: info: service ci-service-check: starting
2025-08-12T13:30:30.138225863Z [ls.io-init] done.
2025-08-12T13:30:30.138669467Z s6-rc: info: service ci-service-check successfully started
2025-08-12T13:30:30.175722112Z 13:30:30 default_worker.1     | Server: cfa63cddd513, Context: sidekiq, Role: background, data: {cpu: {one_min: 4.05, five_min: 2.43, fifteen_min: 2.18}, memory: 0.226889728e9, disk: {available: 852608593920, total: 938656133120, used: 86047539200}}
2025-08-12T13:30:30.203888840Z 13:30:30 performance_worker.1 | Server: cfa63cddd513, Context: sidekiq, Role: background, data: {cpu: {one_min: 4.05, five_min: 2.43, fifteen_min: 2.18}, memory: 0.221372416e9, disk: {available: 852605992960, total: 938656133120, used: 86050140160}}
2025-08-12T13:30:30.236271650Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.176Z pid=302 tid=h72 jid=ceb51c8352e57456d8718c50 class=Upgrade::FixNilFileSizeValues: start
2025-08-12T13:30:30.237546898Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [36671ff7-5a29-447f-a725-a2718becb5f3] Performing Upgrade::FixNilFileSizeValues (Job ID: 36671ff7-5a29-447f-a725-a2718becb5f3) from Sidekiq(upgrade) enqueued at 2025-08-12T13:30:29.789394070Z
2025-08-12T13:30:30.238099581Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.228Z pid=302 tid=h6u jid=6f8fc44c9e7a8745f0aab4ce class=Upgrade::BackfillDataPackages: start
2025-08-12T13:30:30.242171151Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [5f05b895-f421-4cc8-9c7a-0898de601d96] Performing Upgrade::BackfillDataPackages (Job ID: 5f05b895-f421-4cc8-9c7a-0898de601d96) from Sidekiq(upgrade) enqueued at 2025-08-12T13:30:29.791132982Z
2025-08-12T13:30:30.251100154Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.235Z pid=302 tid=h7i jid=d532a31ced8a651817db3d99 class=Upgrade::DisambiguateUsernamesJob: start
2025-08-12T13:30:30.251617366Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [9c2c78fa-9058-42d2-a128-a42cc41d1017] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 9c2c78fa-9058-42d2-a128-a42cc41d1017) from Sidekiq(upgrade) enqueued at 2025-08-12T13:30:29.792258760Z
2025-08-12T13:30:30.252380333Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.236Z pid=302 tid=h7a jid=91f3111c9b8ed5a973f4037e class=Upgrade::UpdateActorsJob: start
2025-08-12T13:30:30.255592632Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d75c5ce8-8f87-404c-96e3-a5d170555760] Performing Upgrade::UpdateActorsJob (Job ID: d75c5ce8-8f87-404c-96e3-a5d170555760) from Sidekiq(upgrade) enqueued at 2025-08-12T13:30:29.793183011Z
2025-08-12T13:30:30.261581744Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [9c2c78fa-9058-42d2-a128-a42cc41d1017] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:30.264641447Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d75c5ce8-8f87-404c-96e3-a5d170555760] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:30.278860594Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [5f05b895-f421-4cc8-9c7a-0898de601d96] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:30.507740252Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [36671ff7-5a29-447f-a725-a2718becb5f3] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:30.565631556Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [36671ff7-5a29-447f-a725-a2718becb5f3] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-08-12T13:30:30.567813040Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [36671ff7-5a29-447f-a725-a2718becb5f3] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.046
2025-08-12T13:30:30.589075462Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [9c2c78fa-9058-42d2-a128-a42cc41d1017] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 9c2c78fa-9058-42d2-a128-a42cc41d1017) from Sidekiq(upgrade) in 337.36ms
2025-08-12T13:30:30.589760863Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [d75c5ce8-8f87-404c-96e3-a5d170555760] Performed Upgrade::UpdateActorsJob (Job ID: d75c5ce8-8f87-404c-96e3-a5d170555760) from Sidekiq(upgrade) in 333.57ms
2025-08-12T13:30:30.590805106Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.590Z pid=302 tid=h7i jid=d532a31ced8a651817db3d99 class=Upgrade::DisambiguateUsernamesJob elapsed=0.355: done
2025-08-12T13:30:30.600948184Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [5f05b895-f421-4cc8-9c7a-0898de601d96] Performed Upgrade::BackfillDataPackages (Job ID: 5f05b895-f421-4cc8-9c7a-0898de601d96) from Sidekiq(upgrade) in 350.29ms
2025-08-12T13:30:30.601220613Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.600Z pid=302 tid=h7a jid=91f3111c9b8ed5a973f4037e class=Upgrade::UpdateActorsJob elapsed=0.364: done
2025-08-12T13:30:30.601334292Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [36671ff7-5a29-447f-a725-a2718becb5f3] Performed Upgrade::FixNilFileSizeValues (Job ID: 36671ff7-5a29-447f-a725-a2718becb5f3) from Sidekiq(upgrade) in 363.3ms
2025-08-12T13:30:30.602391281Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.600Z pid=302 tid=h7i jid=d2c31eff171f0798f1aaae11 class=Upgrade::FixParentCollections: start
2025-08-12T13:30:30.603503611Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [996e998a-1427-4cfa-9139-7bf7ca23c98a] Performing Upgrade::FixParentCollections (Job ID: 996e998a-1427-4cfa-9139-7bf7ca23c98a) from Sidekiq(upgrade) enqueued at 2025-08-12T13:30:29.794094086Z
2025-08-12T13:30:30.604162728Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.601Z pid=302 tid=h6u jid=6f8fc44c9e7a8745f0aab4ce class=Upgrade::BackfillDataPackages elapsed=0.373: done
2025-08-12T13:30:30.604359555Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.602Z pid=302 tid=h7a jid=2f8efd244f902d6d4f87e139 class=Upgrade::PruneOrphanedProblems: start
2025-08-12T13:30:30.608880911Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27] Performing Upgrade::PruneOrphanedProblems (Job ID: bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27) from Sidekiq(upgrade) enqueued at 2025-08-12T13:30:29.795058949Z
2025-08-12T13:30:30.609518275Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.602Z pid=302 tid=h72 jid=ceb51c8352e57456d8718c50 class=Upgrade::FixNilFileSizeValues elapsed=0.426: done
2025-08-12T13:30:30.612802269Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [996e998a-1427-4cfa-9139-7bf7ca23c98a] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:30.721622104Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-08-12T13:30:30.930273461Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-08-12T13:30:30.933669100Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.095
2025-08-12T13:30:30.935320567Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [996e998a-1427-4cfa-9139-7bf7ca23c98a] Performed Upgrade::FixParentCollections (Job ID: 996e998a-1427-4cfa-9139-7bf7ca23c98a) from Sidekiq(upgrade) in 331.88ms
2025-08-12T13:30:30.959514934Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.959Z pid=302 tid=h7i jid=d2c31eff171f0798f1aaae11 class=Upgrade::FixParentCollections elapsed=0.358: done
2025-08-12T13:30:30.961302605Z 13:30:30 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27] Performed Upgrade::PruneOrphanedProblems (Job ID: bf84d1b5-6951-4e32-a9a7-d0b82c9f8a27) from Sidekiq(upgrade) in 356.04ms
2025-08-12T13:30:30.976404470Z 13:30:30 default_worker.1     | INFO  2025-08-12T13:30:30.976Z pid=302 tid=h7a jid=2f8efd244f902d6d4f87e139 class=Upgrade::PruneOrphanedProblems elapsed=0.374: done
2025-08-12T13:30:56.379019476Z 13:30:56 rails.1              | [41a89783-3809-4ebe-9d55-e306d6da7df5] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1393,"duration":76.98,"view":0.0,"db":3.74,"@timestamp":"2025-08-12T13:30:56.378Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-08-12T13:30:57.362033768Z 13:30:57 rails.1              | [ebe476f2-1cd6-492e-88f9-0b7939206e3e] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":94114,"duration":963.04,"view":0.0,"db":24.8,"location":"http://172.17.0.4:3214/","@timestamp":"2025-08-12T13:30:57.361Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-08-12T13:30:57.400075255Z 13:30:57 rails.1              | [4b978d45-db98-469d-8f2c-c4be365a3053] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1055,"duration":19.4,"view":0.0,"db":0.51,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-08-12T13:30:57.387Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-08-12T13:30:58.034797382Z 13:30:58 rails.1              | [0d31caf1-f6d5-4420-8479-2935ec8475af] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":23459,"duration":614.11,"view":491.28,"db":62.09,"@timestamp":"2025-08-12T13:30:58.034Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-08-12T13:30:58.132766503Z 13:30:58 rails.1              | [83a84111-8284-4878-a9c0-8566b4d031db] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1185,"duration":61.96,"view":0.0,"db":3.02,"@timestamp":"2025-08-12T13:30:58.131Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-08-12T13:30:58.434455769Z 13:30:58 rails.1              | [c82ded8c-05d8-4002-9ffd-8115b10d7e5e] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14492,"duration":195.88,"view":0.0,"db":1.44,"location":"http://172.17.0.4:3214/","@timestamp":"2025-08-12T13:30:58.400Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-08-12T13:30:58.462649882Z 13:30:58 rails.1              | [2a8a6b45-887a-4b5c-a0eb-6221ebc9d86e] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1099,"duration":20.02,"view":0.0,"db":1.82,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-08-12T13:30:58.462Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-08-12T13:30:58.801510832Z 13:30:58 rails.1              | [583ca029-6746-42ee-b6d9-b51507c9dfdd] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":23639,"duration":318.87,"view":206.65,"db":1.13,"@timestamp":"2025-08-12T13:30:58.796Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}