2025-07-22T13:31:10.754493487Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-07-22T13:31:10.754733190Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-07-22T13:31:10.802251755Z [mod-init] Running Docker Modification Logic
2025-07-22T13:31:11.013587557Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-07-22T13:31:11.768000186Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-07-22T13:31:12.109123853Z [mod-init] Installing linuxserver/mods:universal-redis
2025-07-22T13:31:12.136799332Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-07-22T13:31:12.164005033Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-07-22T13:31:12.167811729Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-07-22T13:31:12.168025760Z s6-rc: info: service fix-attrs: starting
2025-07-22T13:31:12.168157615Z s6-rc: info: service init-migrations: starting
2025-07-22T13:31:12.168262446Z s6-rc: info: service init-envfile: starting
2025-07-22T13:31:12.174004579Z [migrations] started
2025-07-22T13:31:12.174029780Z [migrations] no migrations found
2025-07-22T13:31:12.174418242Z s6-rc: info: service init-migrations successfully started
2025-07-22T13:31:12.174548885Z s6-rc: info: service init-adduser: starting
2025-07-22T13:31:12.175519720Z s6-rc: info: service fix-attrs successfully started
2025-07-22T13:31:12.175658069Z s6-rc: info: service legacy-cont-init: starting
2025-07-22T13:31:12.178540603Z s6-rc: info: service init-envfile successfully started
2025-07-22T13:31:12.182490146Z s6-rc: info: service legacy-cont-init successfully started
2025-07-22T13:31:12.199563956Z usermod: no changes
2025-07-22T13:31:12.207950383Z ───────────────────────────────────────
2025-07-22T13:31:12.207984933Z 
2025-07-22T13:31:12.207996797Z       ██╗     ███████╗██╗ ██████╗
2025-07-22T13:31:12.208007628Z       ██║     ██╔════╝██║██╔═══██╗
2025-07-22T13:31:12.208017288Z       ██║     ███████╗██║██║   ██║
2025-07-22T13:31:12.208026777Z       ██║     ╚════██║██║██║   ██║
2025-07-22T13:31:12.208036066Z       ███████╗███████║██║╚██████╔╝
2025-07-22T13:31:12.208045545Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-07-22T13:31:12.208056757Z 
2025-07-22T13:31:12.208067058Z    Brought to you by linuxserver.io
2025-07-22T13:31:12.208077790Z ───────────────────────────────────────
2025-07-22T13:31:12.208413967Z 
2025-07-22T13:31:12.208438947Z To support LSIO projects visit:
2025-07-22T13:31:12.208449628Z https://www.linuxserver.io/donate/
2025-07-22T13:31:12.208460120Z 
2025-07-22T13:31:12.208470601Z ───────────────────────────────────────
2025-07-22T13:31:12.208481723Z GID/UID
2025-07-22T13:31:12.208491793Z ───────────────────────────────────────
2025-07-22T13:31:12.213959864Z 
2025-07-22T13:31:12.213984013Z User UID:    911
2025-07-22T13:31:12.213993762Z User GID:    911
2025-07-22T13:31:12.214002139Z ───────────────────────────────────────
2025-07-22T13:31:12.216155275Z Linuxserver.io version: v0.118.0-ls92
2025-07-22T13:31:12.216499668Z Build-date: 2025-07-22T13:20:08+00:00
2025-07-22T13:31:12.216519268Z ───────────────────────────────────────
2025-07-22T13:31:12.216528426Z     
2025-07-22T13:31:12.234485175Z s6-rc: info: service init-adduser successfully started
2025-07-22T13:31:12.234636960Z s6-rc: info: service init-device-perms: starting
2025-07-22T13:31:12.241604120Z s6-rc: info: service init-device-perms successfully started
2025-07-22T13:31:12.241737118Z s6-rc: info: service init-os-end: starting
2025-07-22T13:31:12.243126806Z s6-rc: info: service init-os-end successfully started
2025-07-22T13:31:12.243252840Z s6-rc: info: service init-manyfold-config: starting
2025-07-22T13:31:12.243417712Z s6-rc: info: service init-config: starting
2025-07-22T13:31:12.244999858Z s6-rc: info: service init-config successfully started
2025-07-22T13:31:12.245164028Z s6-rc: info: service init-crontab-config: starting
2025-07-22T13:31:12.256161182Z s6-rc: info: service init-crontab-config successfully started
2025-07-22T13:31:12.273156244Z **** Running Manyfold database init. ****
2025-07-22T13:31:14.475867241Z `/root` is not writable.
2025-07-22T13:31:14.476030960Z Bundler will use `/tmp/bundler20250722-173-3e053c173' as your home directory temporarily.
2025-07-22T13:31:18.914666611Z Server: 4f047f08dc84, Context: rails, Role: web, data: {:cpu=>{:one_min=>1.55, :five_min=>1.52, :fifteen_min=>1.98}, :memory=>0.179232768e9, :disk=>{:available=>861520433152, :total=>938656133120, :used=>77135699968}}
2025-07-22T13:31:18.914698104Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-07-22T13:31:18.914702493Z INFO  2025-07-22T13:31:18.682Z pid=173 tid=5rl: Sidekiq 8.0.5 connecting to Redis with options {:size=>10, :pool_name=>"internal", :url=>nil}
2025-07-22T13:31:18.914718746Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-07-22T13:31:19.921759544Z Migrating to CreateLibraries (20210130201037)
2025-07-22T13:31:19.921791688Z == 20210130201037 CreateLibraries: migrating ==================================
2025-07-22T13:31:19.921801228Z -- create_table(:libraries)
2025-07-22T13:31:19.921809364Z    -> 0.0010s
2025-07-22T13:31:19.921817631Z == 20210130201037 CreateLibraries: migrated (0.0010s) =========================
2025-07-22T13:31:19.921825797Z 
2025-07-22T13:31:19.921833633Z Migrating to CreateModels (20210130203243)
2025-07-22T13:31:19.921841619Z == 20210130203243 CreateModels: migrating =====================================
2025-07-22T13:31:19.921849725Z -- create_table(:models)
2025-07-22T13:31:19.921857621Z    -> 0.0033s
2025-07-22T13:31:19.921865838Z == 20210130203243 CreateModels: migrated (0.0034s) ============================
2025-07-22T13:31:19.921874034Z 
2025-07-22T13:31:19.921882231Z Migrating to CreateParts (20210205230918)
2025-07-22T13:31:19.921890577Z == 20210205230918 CreateParts: migrating ======================================
2025-07-22T13:31:19.921898824Z -- create_table(:parts)
2025-07-22T13:31:19.921906670Z    -> 0.0019s
2025-07-22T13:31:19.921914566Z == 20210205230918 CreateParts: migrated (0.0019s) =============================
2025-07-22T13:31:19.921922582Z 
2025-07-22T13:31:19.921930628Z Migrating to AddFieldsToParts (20210210153744)
2025-07-22T13:31:19.921938484Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-07-22T13:31:19.921946490Z -- add_column(:parts, :presupported, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:19.921954747Z    -> 0.0012s
2025-07-22T13:31:19.921962623Z -- add_column(:parts, :printed, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:19.921971040Z    -> 0.0003s
2025-07-22T13:31:19.921979376Z == 20210210153744 AddFieldsToParts: migrated (0.0016s) ========================
2025-07-22T13:31:19.921987513Z 
2025-07-22T13:31:19.921995649Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-07-22T13:31:19.922003565Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-07-22T13:31:19.922011561Z -- create_table(:tags, {:id=>:integer})
2025-07-22T13:31:19.922019557Z    -> 0.0009s
2025-07-22T13:31:19.922027453Z -- create_table(:taggings, {:id=>:integer})
2025-07-22T13:31:19.922035429Z    -> 0.0006s
2025-07-22T13:31:19.922043235Z -- add_index(:taggings, :tag_id, {:name=>"index_taggings_on_tag_id"})
2025-07-22T13:31:19.922051532Z    -> 0.0002s
2025-07-22T13:31:19.922259400Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {:name=>"taggings_taggable_context_idx"})
2025-07-22T13:31:19.922269771Z    -> 0.0005s
2025-07-22T13:31:19.922278178Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0024s) ===============
2025-07-22T13:31:19.922286755Z 
2025-07-22T13:31:19.922294882Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-07-22T13:31:19.922302958Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-07-22T13:31:19.922311365Z -- add_index(:tags, :name, {:unique=>true, :name=>"index_tags_on_name"})
2025-07-22T13:31:19.922319872Z    -> 0.0002s
2025-07-22T13:31:19.922328199Z -- index_exists?(:taggings, :tag_id, {:name=>"index_taggings_on_tag_id"})
2025-07-22T13:31:19.922336796Z    -> 0.0004s
2025-07-22T13:31:19.922344812Z -- remove_foreign_key(:taggings, :tags)
2025-07-22T13:31:19.922353309Z    -> 0.0297s
2025-07-22T13:31:19.922362718Z -- remove_index(:taggings, :tag_id, {:name=>"index_taggings_on_tag_id"})
2025-07-22T13:31:19.922371005Z    -> 0.0023s
2025-07-22T13:31:19.922378891Z -- remove_index(:taggings, nil, {:name=>"taggings_taggable_context_idx"})
2025-07-22T13:31:19.922387087Z    -> 0.0002s
2025-07-22T13:31:19.922395514Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {:unique=>true, :name=>"taggings_idx"})
2025-07-22T13:31:19.922404482Z    -> 0.0010s
2025-07-22T13:31:19.922412308Z -- add_foreign_key(:taggings, :tags, {:column=>"tag_id"})
2025-07-22T13:31:19.922420454Z    -> 0.0136s
2025-07-22T13:31:19.922428240Z == 20210212143002 AddMissingUniqueIndices: migrated (0.0513s) =================
2025-07-22T13:31:19.922436777Z 
2025-07-22T13:31:19.922444483Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-07-22T13:31:19.922452429Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-07-22T13:31:19.922460485Z -- add_column(:tags, :taggings_count, :integer, {:default=>0})
2025-07-22T13:31:19.922468611Z    -> 0.0019s
2025-07-22T13:31:19.922476427Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.0144s) ===========
2025-07-22T13:31:19.922484393Z 
2025-07-22T13:31:19.922492109Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-07-22T13:31:19.922500015Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-07-22T13:31:19.922508001Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {:name=>"taggings_taggable_context_idx"})
2025-07-22T13:31:19.922516618Z    -> 0.0002s
2025-07-22T13:31:19.922524484Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-07-22T13:31:19.922543071Z 
2025-07-22T13:31:19.922550887Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-07-22T13:31:19.922558833Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-07-22T13:31:19.922566799Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0006s) ==============
2025-07-22T13:31:19.922574805Z 
2025-07-22T13:31:19.922582471Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-07-22T13:31:19.922590547Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-07-22T13:31:19.922599064Z -- index_exists?(:taggings, :tag_id, {:name=>"index_taggings_on_tag_id"})
2025-07-22T13:31:19.922607170Z    -> 0.0014s
2025-07-22T13:31:19.922614976Z -- add_index(:taggings, :tag_id, {:name=>"index_taggings_on_tag_id"})
2025-07-22T13:31:19.922623113Z    -> 0.0002s
2025-07-22T13:31:19.922631179Z -- index_exists?(:taggings, :taggable_id, {:name=>"index_taggings_on_taggable_id"})
2025-07-22T13:31:19.922639365Z    -> 0.0006s
2025-07-22T13:31:19.922647361Z -- add_index(:taggings, :taggable_id, {:name=>"index_taggings_on_taggable_id"})
2025-07-22T13:31:19.922655758Z    -> 0.0002s
2025-07-22T13:31:19.922663975Z -- index_exists?(:taggings, :taggable_type, {:name=>"index_taggings_on_taggable_type"})
2025-07-22T13:31:19.922672201Z    -> 0.0003s
2025-07-22T13:31:19.922679977Z -- add_index(:taggings, :taggable_type, {:name=>"index_taggings_on_taggable_type"})
2025-07-22T13:31:19.922688154Z    -> 0.0002s
2025-07-22T13:31:19.922696340Z -- index_exists?(:taggings, :tagger_id, {:name=>"index_taggings_on_tagger_id"})
2025-07-22T13:31:19.922704547Z    -> 0.0011s
2025-07-22T13:31:19.922712372Z -- add_index(:taggings, :tagger_id, {:name=>"index_taggings_on_tagger_id"})
2025-07-22T13:31:19.922720889Z    -> 0.0002s
2025-07-22T13:31:19.922729036Z -- index_exists?(:taggings, :context, {:name=>"index_taggings_on_context"})
2025-07-22T13:31:19.922737192Z    -> 0.0005s
2025-07-22T13:31:19.922745389Z -- add_index(:taggings, :context, {:name=>"index_taggings_on_context"})
2025-07-22T13:31:19.922753716Z    -> 0.0002s
2025-07-22T13:31:19.922761521Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {:name=>"index_taggings_on_tagger_id_and_tagger_type"})
2025-07-22T13:31:19.922769868Z    -> 0.0006s
2025-07-22T13:31:19.922777654Z -- add_index(:taggings, [:tagger_id, :tagger_type], {:name=>"index_taggings_on_tagger_id_and_tagger_type"})
2025-07-22T13:31:19.922785960Z    -> 0.0001s
2025-07-22T13:31:19.922794117Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {:name=>"taggings_idy"})
2025-07-22T13:31:19.922802414Z    -> 0.0008s
2025-07-22T13:31:19.922819899Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {:name=>"taggings_idy"})
2025-07-22T13:31:19.922828486Z    -> 0.0005s
2025-07-22T13:31:19.922836382Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0075s) =============
2025-07-22T13:31:19.922844619Z 
2025-07-22T13:31:19.922852545Z Migrating to AddPreviewPartToModel (20210220204055)
2025-07-22T13:31:19.922860701Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-07-22T13:31:19.922868988Z -- add_reference(:models, :preview_part, {:null=>true, :foreign_key=>{:to_table=>:parts}})
2025-07-22T13:31:19.922877705Z    -> 0.0363s
2025-07-22T13:31:19.922885781Z == 20210220204055 AddPreviewPartToModel: migrated (0.0363s) ===================
2025-07-22T13:31:19.922894018Z 
2025-07-22T13:31:19.922901994Z Migrating to CreateCreators (20210225232756)
2025-07-22T13:31:19.922910100Z == 20210225232756 CreateCreators: migrating ===================================
2025-07-22T13:31:19.922918417Z -- create_table(:creators)
2025-07-22T13:31:19.922926534Z    -> 0.0021s
2025-07-22T13:31:19.922934971Z == 20210225232756 CreateCreators: migrated (0.0021s) ==========================
2025-07-22T13:31:19.922943658Z 
2025-07-22T13:31:19.922951885Z Migrating to AddCreatorToModels (20210225232841)
2025-07-22T13:31:19.922960241Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-07-22T13:31:19.922968217Z -- add_reference(:models, :creator, {:null=>true, :foreign_key=>true})
2025-07-22T13:31:19.922976885Z    -> 0.0094s
2025-07-22T13:31:19.922984741Z == 20210225232841 AddCreatorToModels: migrated (0.0094s) ======================
2025-07-22T13:31:19.922993007Z 
2025-07-22T13:31:19.923001424Z Migrating to CreateLinks (20210301230017)
2025-07-22T13:31:19.923009571Z == 20210301230017 CreateLinks: migrating ======================================
2025-07-22T13:31:19.923017797Z -- create_table(:links)
2025-07-22T13:31:19.923025793Z    -> 0.0007s
2025-07-22T13:31:19.923033870Z == 20210301230017 CreateLinks: migrated (0.0007s) =============================
2025-07-22T13:31:19.923042136Z 
2025-07-22T13:31:19.923050623Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-07-22T13:31:19.923058660Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-07-22T13:31:19.923066776Z -- remove_column(:creators, :thingiverse_user, :string)
2025-07-22T13:31:19.923074722Z    -> 0.0116s
2025-07-22T13:31:19.923082598Z -- remove_column(:creators, :cults3d_user, :string)
2025-07-22T13:31:19.923090794Z    -> 0.0030s
2025-07-22T13:31:19.923098600Z -- remove_column(:creators, :mmf_user, :string)
2025-07-22T13:31:19.923116616Z    -> 0.0060s
2025-07-22T13:31:19.923124743Z -- remove_column(:creators, :cgtrader_user, :string)
2025-07-22T13:31:19.923132699Z    -> 0.0028s
2025-07-22T13:31:19.923140835Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0239s) ==============
2025-07-22T13:31:19.923148851Z 
2025-07-22T13:31:19.923156647Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-07-22T13:31:19.923164593Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-07-22T13:31:19.923172549Z -- remove_foreign_key(:models, :parts, {:column=>:preview_part_id})
2025-07-22T13:31:19.923180635Z    -> 0.0139s
2025-07-22T13:31:19.923188421Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0140s) ==
2025-07-22T13:31:19.923196397Z 
2025-07-22T13:31:19.923204122Z Migrating to AddYUpToParts (20210318202638)
2025-07-22T13:31:19.923212008Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-07-22T13:31:19.923219944Z -- add_column(:parts, :y_up, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:19.923228061Z    -> 0.0038s
2025-07-22T13:31:19.923235886Z == 20210318202638 AddYUpToParts: migrated (0.0039s) ===========================
2025-07-22T13:31:19.923243852Z 
2025-07-22T13:31:19.923251528Z Migrating to CreateImages (20210321164508)
2025-07-22T13:31:19.923259374Z == 20210321164508 CreateImages: migrating =====================================
2025-07-22T13:31:19.923267390Z -- create_table(:images)
2025-07-22T13:31:19.923275226Z    -> 0.0026s
2025-07-22T13:31:19.923283021Z == 20210321164508 CreateImages: migrated (0.0026s) ============================
2025-07-22T13:31:19.923291007Z 
2025-07-22T13:31:19.923298663Z Migrating to CreateDelayedJobs (20210330215825)
2025-07-22T13:31:19.923306549Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-07-22T13:31:19.923314585Z -- create_table(:delayed_jobs)
2025-07-22T13:31:19.923322411Z    -> 0.0030s
2025-07-22T13:31:19.923330547Z -- add_index(:delayed_jobs, [:priority, :run_at], {:name=>"delayed_jobs_priority"})
2025-07-22T13:31:19.923338754Z    -> 0.0002s
2025-07-22T13:31:19.923346559Z == 20210330215825 CreateDelayedJobs: migrated (0.0032s) =======================
2025-07-22T13:31:19.923354515Z 
2025-07-22T13:31:19.923362201Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-07-22T13:31:19.923370107Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-07-22T13:31:19.923378083Z -- rename_table(:parts, :model_files)
2025-07-22T13:31:19.923385959Z    -> 0.0015s
2025-07-22T13:31:19.923403073Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-07-22T13:31:19.923411089Z    -> 0.0122s
2025-07-22T13:31:19.923419516Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0138s) =================
2025-07-22T13:31:19.923427663Z 
2025-07-22T13:31:19.923435398Z Migrating to RemoveImagesTable (20220106220519)
2025-07-22T13:31:20.171925295Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-07-22T13:31:20.171969504Z -- drop_table(:images)
2025-07-22T13:31:20.171979103Z    -> 0.0003s
2025-07-22T13:31:20.171987680Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-07-22T13:31:20.171995987Z 
2025-07-22T13:31:20.172003843Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-07-22T13:31:20.172011979Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-07-22T13:31:20.172020096Z -- table_exists?(:active_storage_blobs)
2025-07-22T13:31:20.172027992Z    -> 0.0003s
2025-07-22T13:31:20.172036228Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0004s) ======
2025-07-22T13:31:20.172044825Z 
2025-07-22T13:31:20.172052992Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-07-22T13:31:20.172061188Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-07-22T13:31:20.172069205Z -- table_exists?(:active_storage_blobs)
2025-07-22T13:31:20.172077080Z    -> 0.0007s
2025-07-22T13:31:20.172084996Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0007s) =======
2025-07-22T13:31:20.172093002Z 
2025-07-22T13:31:20.172100708Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-07-22T13:31:20.172108734Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-07-22T13:31:20.172116730Z -- table_exists?(:active_storage_blobs)
2025-07-22T13:31:20.172124606Z    -> 0.0005s
2025-07-22T13:31:20.172132462Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0005s) 
2025-07-22T13:31:20.172140498Z 
2025-07-22T13:31:20.172148174Z Migrating to DeviseCreateUsers (20220614210023)
2025-07-22T13:31:20.172156059Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-07-22T13:31:20.172164536Z -- create_table(:users)
2025-07-22T13:31:20.172172402Z    -> 0.0027s
2025-07-22T13:31:20.172180228Z -- add_index(:users, :email, {:unique=>true, :name=>"index_users_on_email"})
2025-07-22T13:31:20.172188765Z    -> 0.0004s
2025-07-22T13:31:20.172196701Z == 20220614210023 DeviseCreateUsers: migrated (0.0032s) =======================
2025-07-22T13:31:20.172231231Z 
2025-07-22T13:31:20.172239387Z Migrating to AddUsernameToUsers (20220614211256)
2025-07-22T13:31:20.172247313Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-07-22T13:31:20.172255319Z -- add_column(:users, :username, :string, {:null=>false})
2025-07-22T13:31:20.172263476Z    -> 0.0068s
2025-07-22T13:31:20.172271362Z -- add_index(:users, :username, {:unique=>true, :name=>"index_users_on_username"})
2025-07-22T13:31:20.172279789Z    -> 0.0001s
2025-07-22T13:31:20.172287614Z == 20220614211256 AddUsernameToUsers: migrated (0.0070s) ======================
2025-07-22T13:31:20.172295691Z 
2025-07-22T13:31:20.172303376Z Migrating to AddAdminToUsers (20220614213902)
2025-07-22T13:31:20.172311312Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-07-22T13:31:20.172319278Z -- add_column(:users, :admin, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:20.172327926Z    -> 0.0005s
2025-07-22T13:31:20.172335922Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-07-22T13:31:20.172344529Z 
2025-07-22T13:31:20.172352224Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-07-22T13:31:20.172361473Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-07-22T13:31:20.172369650Z -- add_column(:users, :pagination_settings, :json, {:default=>{"models"=>true, "creators"=>true, "collections"=>true, "per_page"=>12}})
2025-07-22T13:31:20.172378918Z    -> 0.0036s
2025-07-22T13:31:20.172387075Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0037s) =============
2025-07-22T13:31:20.172395562Z 
2025-07-22T13:31:20.172403267Z Migrating to CreateSettings (20220619174307)
2025-07-22T13:31:20.172411323Z == 20220619174307 CreateSettings: migrating ===================================
2025-07-22T13:31:20.172419350Z -- create_table(:settings)
2025-07-22T13:31:20.172427496Z    -> 0.0007s
2025-07-22T13:31:20.172435342Z -- add_index(:settings, [:var], {:unique=>true, :name=>"index_settings_on_var"})
2025-07-22T13:31:20.172443689Z    -> 0.0002s
2025-07-22T13:31:20.172451484Z == 20220619174307 CreateSettings: migrated (0.0009s) ==========================
2025-07-22T13:31:20.172459921Z 
2025-07-22T13:31:20.172467998Z Migrating to AddScaleFactorToModels (20220626152444)
2025-07-22T13:31:20.172476555Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-07-22T13:31:20.172484551Z -- add_column(:models, :scale_factor, :decimal, {:null=>false, :default=>100.0})
2025-07-22T13:31:20.172493238Z    -> 0.0035s
2025-07-22T13:31:20.172501485Z == 20220626152444 AddScaleFactorToModels: migrated (0.0039s) ==================
2025-07-22T13:31:20.172519060Z 
2025-07-22T13:31:20.172526986Z Migrating to AddDigestToModelFiles (20220702202932)
2025-07-22T13:31:20.172535333Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-07-22T13:31:20.172543490Z -- add_column(:model_files, :digest, :string)
2025-07-22T13:31:20.172551526Z    -> 0.0011s
2025-07-22T13:31:20.172559522Z -- add_index(:model_files, :digest, {:name=>"index_model_files_on_digest"})
2025-07-22T13:31:20.172567889Z    -> 0.0002s
2025-07-22T13:31:20.172576225Z == 20220702202932 AddDigestToModelFiles: migrated (0.0019s) ===================
2025-07-22T13:31:20.172584272Z 
2025-07-22T13:31:20.172592528Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-07-22T13:31:20.172600975Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-07-22T13:31:20.172609032Z -- add_column(:users, :renderer_settings, :json, {:default=>{"grid_width"=>200, "grid_depth"=>200, "show_grid"=>true, "enable_pan_zoom"=>false, "background_colour"=>"#000000", "object_colour"=>"#ffffff", "render_style"=>"original"}})
2025-07-22T13:31:20.172620895Z    -> 0.0008s
2025-07-22T13:31:20.172629222Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0010s) ==============
2025-07-22T13:31:20.172637479Z 
2025-07-22T13:31:20.172645615Z Migrating to CreateProblems (20221210001132)
2025-07-22T13:31:20.172653712Z == 20221210001132 CreateProblems: migrating ===================================
2025-07-22T13:31:20.172661948Z -- create_table(:problems)
2025-07-22T13:31:20.172670305Z    -> 0.0006s
2025-07-22T13:31:20.172678231Z == 20221210001132 CreateProblems: migrated (0.0008s) ==========================
2025-07-22T13:31:20.172686588Z 
2025-07-22T13:31:20.172695355Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-07-22T13:31:20.172703382Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-07-22T13:31:20.172711358Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0046s) ========
2025-07-22T13:31:20.172719554Z 
2025-07-22T13:31:20.172727310Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-07-22T13:31:20.172735346Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-07-22T13:31:20.172743372Z -- create_table(:favorites, {:force=>true})
2025-07-22T13:31:20.172751438Z    -> 0.0021s
2025-07-22T13:31:20.172759525Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {:name=>"fk_favorites"})
2025-07-22T13:31:20.172768693Z    -> 0.0001s
2025-07-22T13:31:20.172776489Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {:name=>"fk_favoritables"})
2025-07-22T13:31:20.172794305Z    -> 0.0001s
2025-07-22T13:31:20.172802261Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {:name=>"uniq_favorites__and_favoritables", :unique=>true})
2025-07-22T13:31:20.172811559Z    -> 0.0001s
2025-07-22T13:31:20.172819335Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0027s) ================
2025-07-22T13:31:20.172827421Z 
2025-07-22T13:31:20.172835498Z Migrating to MovePrintedToFavorites (20221220223040)
2025-07-22T13:31:20.172843644Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-07-22T13:31:20.172851840Z == 20221220223040 MovePrintedToFavorites: migrated (0.0054s) ==================
2025-07-22T13:31:20.172860267Z 
2025-07-22T13:31:20.172868033Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-07-22T13:31:20.172876230Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-07-22T13:31:20.172884436Z -- remove_column(:model_files, :printed, :boolean)
2025-07-22T13:31:20.172892492Z    -> 0.0084s
2025-07-22T13:31:20.172900519Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0085s) ===============
2025-07-22T13:31:20.172908465Z 
2025-07-22T13:31:20.172916340Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-07-22T13:31:20.172924236Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-07-22T13:31:20.172932212Z -- add_column(:models, :notes, :text)
2025-07-22T13:31:20.172940108Z    -> 0.0006s
2025-07-22T13:31:20.172948425Z -- add_column(:models, :excerpt, :text)
2025-07-22T13:31:20.172956601Z    -> 0.0008s
2025-07-22T13:31:20.172964407Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0014s) =================
2025-07-22T13:31:20.172972584Z 
2025-07-22T13:31:20.172980259Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-07-22T13:31:20.172988135Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-07-22T13:31:20.172996101Z -- add_column(:creators, :notes, :text)
2025-07-22T13:31:20.173004237Z    -> 0.0005s
2025-07-22T13:31:20.173012304Z -- add_column(:creators, :excerpt, :text)
2025-07-22T13:31:20.173020139Z    -> 0.0004s
2025-07-22T13:31:20.173027945Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-07-22T13:31:20.173035931Z 
2025-07-22T13:31:20.173044118Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-07-22T13:31:20.173052094Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-07-22T13:31:20.173060060Z -- add_column(:model_files, :notes, :text)
2025-07-22T13:31:20.173079769Z    -> 0.0005s
2025-07-22T13:31:20.173087675Z -- add_column(:model_files, :excerpt, :text)
2025-07-22T13:31:20.173095551Z    -> 0.0004s
2025-07-22T13:31:20.173103698Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0010s) =============
2025-07-22T13:31:20.173112135Z 
2025-07-22T13:31:20.173119880Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-07-22T13:31:20.173128037Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-07-22T13:31:20.173136173Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0049s) =================
2025-07-22T13:31:20.173144670Z 
2025-07-22T13:31:20.173152566Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-07-22T13:31:20.173160542Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-07-22T13:31:20.173168739Z -- remove_column(:models, :scale_factor, :decimal, {:default=>"100.0", :null=>false})
2025-07-22T13:31:20.173177326Z    -> 0.0117s
2025-07-22T13:31:20.173185522Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0117s) =============
2025-07-22T13:31:20.173193889Z 
2025-07-22T13:31:20.173201996Z Migrating to RenameExcerptToCaption (20230222155910)
2025-07-22T13:31:20.173210162Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-07-22T13:31:20.173218349Z -- rename_column(:creators, :excerpt, :caption)
2025-07-22T13:31:20.173226445Z    -> 0.0058s
2025-07-22T13:31:20.173234371Z -- rename_column(:models, :excerpt, :caption)
2025-07-22T13:31:20.173242517Z    -> 0.0114s
2025-07-22T13:31:20.173250373Z -- rename_column(:model_files, :excerpt, :caption)
2025-07-22T13:31:20.173258259Z    -> 0.0087s
2025-07-22T13:31:20.173266065Z == 20230222155910 RenameExcerptToCaption: migrated (0.0272s) ==================
2025-07-22T13:31:20.173274141Z 
2025-07-22T13:31:20.173281786Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-07-22T13:31:20.173289722Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-07-22T13:31:20.173297668Z -- add_column(:libraries, :notes, :string)
2025-07-22T13:31:20.173305724Z    -> 0.0009s
2025-07-22T13:31:20.173313560Z -- add_column(:libraries, :caption, :string)
2025-07-22T13:31:20.173321426Z    -> 0.0005s
2025-07-22T13:31:20.173329242Z -- add_column(:libraries, :name, :string)
2025-07-22T13:31:20.173337528Z    -> 0.0008s
2025-07-22T13:31:20.173345545Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0036s) ============
2025-07-22T13:31:20.173353711Z 
2025-07-22T13:31:20.173361346Z Migrating to AddTagregexToLibrary (20230305180823)
2025-07-22T13:31:20.173566059Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-07-22T13:31:20.173575438Z -- add_column(:libraries, :tag_regex, :text)
2025-07-22T13:31:20.173583374Z    -> 0.0010s
2025-07-22T13:31:20.173591760Z == 20230305180823 AddTagregexToLibrary: migrated (0.0014s) ====================
2025-07-22T13:31:20.173600047Z 
2025-07-22T13:31:20.173607733Z Migrating to AddIconToLibrary (20230307215826)
2025-07-22T13:31:20.173615628Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-07-22T13:31:20.369696553Z -- add_column(:libraries, :icon, :text)
2025-07-22T13:31:20.369739399Z    -> 0.0009s
2025-07-22T13:31:20.369749480Z == 20230307215826 AddIconToLibrary: migrated (0.0012s) ========================
2025-07-22T13:31:20.369757967Z 
2025-07-22T13:31:20.369766173Z Migrating to CreateCollection (20230308004237)
2025-07-22T13:31:20.369774229Z == 20230308004237 CreateCollection: migrating =================================
2025-07-22T13:31:20.369782436Z -- create_table(:collections)
2025-07-22T13:31:20.369790422Z    -> 0.0012s
2025-07-22T13:31:20.369798338Z == 20230308004237 CreateCollection: migrated (0.0015s) ========================
2025-07-22T13:31:20.369806574Z 
2025-07-22T13:31:20.369814510Z Migrating to AddCollectionToModels (20230308005021)
2025-07-22T13:31:20.369822707Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-07-22T13:31:20.369831314Z -- add_reference(:models, :collection, {:null=>true, :foreign_key=>true})
2025-07-22T13:31:20.369839781Z    -> 0.0101s
2025-07-22T13:31:20.369848068Z == 20230308005021 AddCollectionToModels: migrated (0.0102s) ===================
2025-07-22T13:31:20.369856936Z 
2025-07-22T13:31:20.369865293Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-07-22T13:31:20.369873589Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-07-22T13:31:20.369881916Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0014s) =============
2025-07-22T13:31:20.369890123Z 
2025-07-22T13:31:20.369898029Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-07-22T13:31:20.369906175Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-07-22T13:31:20.369914572Z -- rename_column(:collections, :excerpt, :caption)
2025-07-22T13:31:20.369923239Z    -> 0.0032s
2025-07-22T13:31:20.369931696Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0032s) ========
2025-07-22T13:31:20.369939763Z 
2025-07-22T13:31:20.369947919Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-07-22T13:31:20.369955825Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-07-22T13:31:20.369992689Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-07-22T13:31:20.370001076Z 
2025-07-22T13:31:20.370008752Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-07-22T13:31:20.370016678Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-07-22T13:31:20.370024754Z -- add_column(:users, :tag_cloud_settings, :json, {:default=>{"threshold"=>2, "heatmap"=>true, "keypair"=>true, "sorting"=>"frequency"}})
2025-07-22T13:31:20.370034293Z    -> 0.0007s
2025-07-22T13:31:20.370042259Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0007s) ===============
2025-07-22T13:31:20.370050275Z 
2025-07-22T13:31:20.370058492Z Migrating to AddCollectionToCollections (20230324000000)
2025-07-22T13:31:20.370066638Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-07-22T13:31:20.370074594Z -- add_reference(:collections, :collection, {:null=>true, :foreign_key=>true})
2025-07-22T13:31:20.370083141Z    -> 0.0056s
2025-07-22T13:31:20.370092781Z == 20230324000000 AddCollectionToCollections: migrated (0.0059s) ==============
2025-07-22T13:31:20.370101108Z 
2025-07-22T13:31:20.370108923Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-07-22T13:31:20.370117130Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-07-22T13:31:20.370125627Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0015s) =========
2025-07-22T13:31:20.370133884Z 
2025-07-22T13:31:20.370141840Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-07-22T13:31:20.370150156Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-07-22T13:31:20.370158343Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0019s) 
2025-07-22T13:31:20.370166599Z 
2025-07-22T13:31:20.370174555Z Migrating to AddSlugs (20230615135601)
2025-07-22T13:31:20.370183042Z == 20230615135601 AddSlugs: migrating =========================================
2025-07-22T13:31:20.370191630Z -- add_column(:models, :slug, :string)
2025-07-22T13:31:20.370199796Z    -> 0.0006s
2025-07-22T13:31:20.370207893Z -- add_index(:models, :slug, {:name=>"index_models_on_slug"})
2025-07-22T13:31:20.370216440Z    -> 0.0005s
2025-07-22T13:31:20.370224336Z -- add_column(:collections, :slug, :string)
2025-07-22T13:31:20.370232262Z    -> 0.0005s
2025-07-22T13:31:20.370240508Z -- add_index(:collections, :slug, {:name=>"index_collections_on_slug"})
2025-07-22T13:31:20.370248945Z    -> 0.0001s
2025-07-22T13:31:20.370256851Z -- add_column(:creators, :slug, :string)
2025-07-22T13:31:20.370274988Z    -> 0.0005s
2025-07-22T13:31:20.370283154Z -- add_index(:creators, :slug, {:name=>"index_creators_on_slug"})
2025-07-22T13:31:20.370291250Z    -> 0.0001s
2025-07-22T13:31:20.370299317Z == 20230615135601 AddSlugs: migrated (0.0025s) ================================
2025-07-22T13:31:20.370307764Z 
2025-07-22T13:31:20.370315760Z Migrating to GenerateSlugs (20230617222353)
2025-07-22T13:31:20.370323876Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-07-22T13:31:20.370332654Z == 20230617222353 GenerateSlugs: migrated (0.0114s) ===========================
2025-07-22T13:31:20.370340840Z 
2025-07-22T13:31:20.370348886Z Migrating to MakeNamesUnique (20230628194944)
2025-07-22T13:31:20.370357143Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-07-22T13:31:20.370365320Z == 20230628194944 MakeNamesUnique: migrated (0.0008s) =========================
2025-07-22T13:31:20.370373546Z 
2025-07-22T13:31:20.370381402Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-07-22T13:31:20.370389618Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-07-22T13:31:20.370398597Z -- add_index(:creators, :name, {:unique=>true, :name=>"index_creators_on_name"})
2025-07-22T13:31:20.370407054Z    -> 0.0002s
2025-07-22T13:31:20.370414929Z -- remove_index(:creators, :slug)
2025-07-22T13:31:20.370423036Z    -> 0.0004s
2025-07-22T13:31:20.370430912Z -- add_index(:creators, :slug, {:unique=>true, :name=>"index_creators_on_slug"})
2025-07-22T13:31:20.370439168Z    -> 0.0001s
2025-07-22T13:31:20.370447034Z -- add_index(:collections, :name, {:unique=>true, :name=>"index_collections_on_name"})
2025-07-22T13:31:20.370455351Z    -> 0.0001s
2025-07-22T13:31:20.370463497Z -- remove_index(:collections, :slug)
2025-07-22T13:31:20.370471363Z    -> 0.0030s
2025-07-22T13:31:20.370479640Z -- add_index(:collections, :slug, {:unique=>true, :name=>"index_collections_on_slug"})
2025-07-22T13:31:20.370488167Z    -> 0.0002s
2025-07-22T13:31:20.370496764Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0043s) ======
2025-07-22T13:31:20.370504760Z 
2025-07-22T13:31:20.370512496Z Migrating to AddSizeToModelFiles (20230707082403)
2025-07-22T13:31:20.370520843Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-07-22T13:31:20.370528919Z -- add_column(:model_files, :size, :integer)
2025-07-22T13:31:20.370536785Z    -> 0.0006s
2025-07-22T13:31:20.370544580Z == 20230707082403 AddSizeToModelFiles: migrated (0.0007s) =====================
2025-07-22T13:31:20.370562517Z 
2025-07-22T13:31:20.370570433Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-07-22T13:31:20.370578459Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-07-22T13:31:20.370586445Z -- change_column(:model_files, :size, :bigint)
2025-07-22T13:31:20.370594401Z    -> 0.0066s
2025-07-22T13:31:20.370602297Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0068s) ==================
2025-07-22T13:31:20.370610293Z 
2025-07-22T13:31:20.370617978Z Migrating to AddNoteToProblems (20230711111009)
2025-07-22T13:31:20.370625884Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-07-22T13:31:20.370633890Z -- add_column(:problems, :note, :string, {:default=>nil})
2025-07-22T13:31:20.370641936Z    -> 0.0008s
2025-07-22T13:31:20.370649752Z == 20230711111009 AddNoteToProblems: migrated (0.0008s) =======================
2025-07-22T13:31:20.370657758Z 
2025-07-22T13:31:20.370665524Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-07-22T13:31:20.370673490Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-07-22T13:31:20.370682007Z -- 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}})
2025-07-22T13:31:20.370694883Z    -> 0.0006s
2025-07-22T13:31:20.370702769Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-07-22T13:31:20.370710835Z 
2025-07-22T13:31:20.370718531Z Migrating to AddLicenseToModel (20240127143358)
2025-07-22T13:31:20.370726707Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-07-22T13:31:20.370735014Z -- add_column(:models, :license, :string)
2025-07-22T13:31:20.370743371Z    -> 0.0006s
2025-07-22T13:31:20.370751186Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-07-22T13:31:20.370759603Z 
2025-07-22T13:31:20.370767469Z Migrating to AddIgnoredToProblems (20240131134832)
2025-07-22T13:31:20.370775586Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-07-22T13:31:20.370783612Z -- add_column(:problems, :ignored, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:20.370792019Z    -> 0.0007s
2025-07-22T13:31:20.370800826Z == 20240131134832 AddIgnoredToProblems: migrated (0.0007s) ====================
2025-07-22T13:31:20.370809073Z 
2025-07-22T13:31:20.370816919Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-07-22T13:31:20.370834424Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-07-22T13:31:20.370842921Z -- add_reference(:model_files, :presupported_version, {:foreign_key=>{:to_table=>:model_files}})
2025-07-22T13:31:20.370851208Z    -> 0.0099s
2025-07-22T13:31:20.370859304Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0099s) ======
2025-07-22T13:31:20.370868412Z 
2025-07-22T13:31:20.370876138Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-07-22T13:31:20.370884304Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-07-22T13:31:20.370892321Z -- add_column(:users, :file_list_settings, :json, {:default=>{"hide_presupported_versions"=>true}})
2025-07-22T13:31:20.370900988Z    -> 0.0006s
2025-07-22T13:31:20.370908934Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-07-22T13:31:20.370917010Z 
2025-07-22T13:31:20.370925247Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-07-22T13:31:20.370933594Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-07-22T13:31:20.370942261Z -- add_index(:libraries, :path, {:unique=>true, :name=>"index_libraries_on_path"})
2025-07-22T13:31:20.370950949Z    -> 0.0002s
2025-07-22T13:31:20.370958794Z -- add_index(:models, [:path, :library_id], {:unique=>true, :name=>"index_models_on_path_and_library_id"})
2025-07-22T13:31:20.370967382Z    -> 0.0001s
2025-07-22T13:31:20.370975398Z -- add_index(:model_files, [:filename, :model_id], {:unique=>true, :name=>"index_model_files_on_filename_and_model_id"})
2025-07-22T13:31:20.370984085Z    -> 0.0001s
2025-07-22T13:31:20.370992011Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {:unique=>true, :name=>"index_problems_on_category_and_problematic_id_and_type"})
2025-07-22T13:31:20.371001100Z    -> 0.0006s
2025-07-22T13:31:20.371009266Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0013s) =================
2025-07-22T13:31:20.371017443Z 
2025-07-22T13:31:20.371025288Z Migrating to CreateFlipperTables (20240306095646)
2025-07-22T13:31:20.371033395Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-07-22T13:31:20.371041581Z -- create_table(:flipper_features)
2025-07-22T13:31:20.371050299Z    -> 0.0008s
2025-07-22T13:31:20.371058074Z -- add_index(:flipper_features, :key, {:unique=>true, :name=>"index_flipper_features_on_key"})
2025-07-22T13:31:20.371066622Z    -> 0.0007s
2025-07-22T13:31:20.371074798Z -- create_table(:flipper_gates)
2025-07-22T13:31:20.371082694Z    -> 0.0002s
2025-07-22T13:31:20.371090600Z -- add_index(:flipper_gates, [:feature_key, :key, :value], {:unique=>true, :length=>{:value=>255}, :name=>"index_flipper_gates_on_feature_key_and_key_and_value"})
2025-07-22T13:31:20.371109227Z    -> 0.0001s
2025-07-22T13:31:20.588498138Z == 20240306095646 CreateFlipperTables: migrated (0.0021s) =====================
2025-07-22T13:31:20.588535884Z 
2025-07-22T13:31:20.588545503Z Migrating to RolifyCreateRoles (20240319155251)
2025-07-22T13:31:20.588554261Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-07-22T13:31:20.588562758Z -- create_table(:roles)
2025-07-22T13:31:20.588570875Z    -> 0.0040s
2025-07-22T13:31:20.588579432Z -- create_table(:users_roles, {:id=>false})
2025-07-22T13:31:20.588587749Z    -> 0.0005s
2025-07-22T13:31:20.588595955Z -- add_index(:roles, :name, {:name=>"index_roles_on_name"})
2025-07-22T13:31:20.588604552Z    -> 0.0006s
2025-07-22T13:31:20.588612659Z -- add_index(:roles, [:name, :resource_type, :resource_id], {:name=>"index_roles_on_name_and_resource_type_and_resource_id"})
2025-07-22T13:31:20.588622018Z    -> 0.0001s
2025-07-22T13:31:20.588629954Z -- add_index(:users_roles, [:user_id, :role_id], {:name=>"index_users_roles_on_user_id_and_role_id"})
2025-07-22T13:31:20.588638621Z    -> 0.0001s
2025-07-22T13:31:20.588646587Z == 20240319155251 RolifyCreateRoles: migrated (0.0074s) =======================
2025-07-22T13:31:20.588654683Z 
2025-07-22T13:31:20.588662489Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-07-22T13:31:20.588670535Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-07-22T13:31:20.588678581Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0034s) ==================
2025-07-22T13:31:20.588686698Z 
2025-07-22T13:31:20.588694433Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-07-22T13:31:20.588702700Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-07-22T13:31:20.588711067Z -- remove_column(:users, :admin, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:20.588719384Z    -> 0.0134s
2025-07-22T13:31:20.588727420Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0137s) ====================
2025-07-22T13:31:20.588735526Z 
2025-07-22T13:31:20.588743302Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-07-22T13:31:20.588751588Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-07-22T13:31:20.588759635Z -- add_column(:users, :reset_password_token, :string)
2025-07-22T13:31:20.588767581Z    -> 0.0010s
2025-07-22T13:31:20.588775717Z -- add_index(:users, :reset_password_token, {:unique=>true, :name=>"index_users_on_reset_password_token"})
2025-07-22T13:31:20.588784435Z    -> 0.0004s
2025-07-22T13:31:20.588959768Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0019s) ============
2025-07-22T13:31:20.588969597Z 
2025-07-22T13:31:20.588977443Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-07-22T13:31:20.588985730Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-07-22T13:31:20.588993856Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0052s) ==============
2025-07-22T13:31:20.589001902Z 
2025-07-22T13:31:20.589009608Z Migrating to AddRememberableToUsers (20240410221112)
2025-07-22T13:31:20.589017534Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-07-22T13:31:20.589025901Z -- add_column(:users, :remember_created_at, :datetime)
2025-07-22T13:31:20.589033877Z    -> 0.0007s
2025-07-22T13:31:20.589043216Z == 20240410221112 AddRememberableToUsers: migrated (0.0010s) ==================
2025-07-22T13:31:20.589051973Z 
2025-07-22T13:31:20.589059819Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-07-22T13:31:20.589067785Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-07-22T13:31:20.589075841Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-07-22T13:31:20.589083988Z    -> 0.0006s
2025-07-22T13:31:20.589092054Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0020s) ===========
2025-07-22T13:31:20.589100341Z 
2025-07-22T13:31:20.589108597Z Migrating to DropDelayedJobs (20240418112821)
2025-07-22T13:31:20.589116543Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-07-22T13:31:20.589124580Z -- drop_table(:delayed_jobs)
2025-07-22T13:31:20.589132495Z    -> 0.0006s
2025-07-22T13:31:20.589140401Z == 20240418112821 DropDelayedJobs: migrated (0.0009s) =========================
2025-07-22T13:31:20.589148438Z 
2025-07-22T13:31:20.589156173Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-07-22T13:31:20.589164139Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-07-22T13:31:20.589172135Z -- add_column(:users, :interface_language, :string)
2025-07-22T13:31:20.589180482Z    -> 0.0014s
2025-07-22T13:31:20.589188809Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0015s) =============
2025-07-22T13:31:20.589197176Z 
2025-07-22T13:31:20.589204971Z Migrating to AddLockableToUsers (20240610120318)
2025-07-22T13:31:20.589213068Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-07-22T13:31:20.589221294Z -- change_table(:users)
2025-07-22T13:31:20.589229391Z    -> 0.0014s
2025-07-22T13:31:20.589237447Z == 20240610120318 AddLockableToUsers: migrated (0.0015s) ======================
2025-07-22T13:31:20.589256275Z 
2025-07-22T13:31:20.589264161Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-07-22T13:31:20.589272107Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-07-22T13:31:20.589280103Z -- add_column(:model_files, :attachment_data, :json)
2025-07-22T13:31:20.589288039Z    -> 0.0006s
2025-07-22T13:31:20.589295925Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0008s) ===========
2025-07-22T13:31:20.589303971Z 
2025-07-22T13:31:20.589311947Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-07-22T13:31:20.589320133Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-07-22T13:31:20.589328139Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0023s) ==================
2025-07-22T13:31:20.589336166Z 
2025-07-22T13:31:20.589344212Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-07-22T13:31:20.589352418Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-07-22T13:31:20.589360404Z -- add_column(:libraries, :storage_service, :string, {:null=>false, :default=>"filesystem"})
2025-07-22T13:31:20.589368791Z    -> 0.0006s
2025-07-22T13:31:20.589376707Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0010s) ============
2025-07-22T13:31:20.589385064Z 
2025-07-22T13:31:20.589392790Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-07-22T13:31:20.589401197Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-07-22T13:31:20.589409273Z -- add_column(:libraries, :s3_endpoint, :string, {:default=>nil})
2025-07-22T13:31:20.589417439Z    -> 0.0006s
2025-07-22T13:31:20.589425425Z -- add_column(:libraries, :s3_region, :string, {:default=>nil})
2025-07-22T13:31:20.589433502Z    -> 0.0005s
2025-07-22T13:31:20.589441377Z -- add_column(:libraries, :s3_bucket, :string, {:default=>nil})
2025-07-22T13:31:20.589449945Z    -> 0.0005s
2025-07-22T13:31:20.589457801Z -- add_column(:libraries, :s3_access_key_id, :string, {:default=>nil})
2025-07-22T13:31:20.589465887Z    -> 0.0005s
2025-07-22T13:31:20.589473743Z -- add_column(:libraries, :s3_secret_access_key, :string, {:default=>nil})
2025-07-22T13:31:20.589481909Z    -> 0.0007s
2025-07-22T13:31:20.589489995Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0030s) ====================
2025-07-22T13:31:20.589498011Z 
2025-07-22T13:31:20.589505777Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-07-22T13:31:20.589514054Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-07-22T13:31:20.589522471Z -- remove_index(:libraries, :path)
2025-07-22T13:31:20.589540707Z    -> 0.0004s
2025-07-22T13:31:20.589548874Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0006s) ================
2025-07-22T13:31:20.589556940Z 
2025-07-22T13:31:20.589564676Z Migrating to CreateFederailsActors (20240727113215)
2025-07-22T13:31:20.589572652Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-07-22T13:31:20.589581199Z -- create_table(:federails_actors)
2025-07-22T13:31:20.589589426Z    -> 0.0008s
2025-07-22T13:31:20.589597341Z -- foreign_key_exists?(:federails_actors, :users)
2025-07-22T13:31:20.589605308Z    -> 0.0007s
2025-07-22T13:31:20.589613254Z -- remove_foreign_key(:federails_actors, :users)
2025-07-22T13:31:20.589621470Z    -> 0.0072s
2025-07-22T13:31:20.589629747Z -- remove_index(:federails_actors, :user_id)
2025-07-22T13:31:20.589638013Z    -> 0.0004s
2025-07-22T13:31:20.589646150Z -- add_index(:federails_actors, :user_id, {:unique=>true, :name=>"index_federails_actors_on_user_id"})
2025-07-22T13:31:20.589654978Z    -> 0.0001s
2025-07-22T13:31:20.589663044Z -- add_foreign_key(:federails_actors, :users)
2025-07-22T13:31:20.589671461Z    -> 0.0070s
2025-07-22T13:31:20.589679517Z == 20240727113215 CreateFederailsActors: migrated (0.0164s) ===================
2025-07-22T13:31:20.589687713Z 
2025-07-22T13:31:20.589695619Z Migrating to CreateFederailsFollowings (20240727113216)
2025-07-22T13:31:20.589703555Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-07-22T13:31:20.589711732Z -- create_table(:federails_followings)
2025-07-22T13:31:20.589719878Z    -> 0.0017s
2025-07-22T13:31:20.589728185Z == 20240727113216 CreateFederailsFollowings: migrated (0.0017s) ===============
2025-07-22T13:31:20.589736381Z 
2025-07-22T13:31:20.589744297Z Migrating to CreateFederailsActivities (20240727113217)
2025-07-22T13:31:20.589752845Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-07-22T13:31:20.589760831Z -- create_table(:federails_activities)
2025-07-22T13:31:20.589768717Z    -> 0.0017s
2025-07-22T13:31:20.589776633Z == 20240727113217 CreateFederailsActivities: migrated (0.0017s) ===============
2025-07-22T13:31:20.589784679Z 
2025-07-22T13:31:20.589792615Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-07-22T13:31:20.589801102Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-07-22T13:31:20.589809188Z -- remove_foreign_key(:federails_actors, {:column=>:user_id, :to_table=>"users"})
2025-07-22T13:31:20.589817585Z    -> 0.0078s
2025-07-22T13:31:20.589825421Z -- remove_index(:federails_actors, :user_id, {:unique=>true})
2025-07-22T13:31:20.589843567Z    -> 0.0004s
2025-07-22T13:31:20.589851543Z -- change_table(:federails_actors)
2025-07-22T13:31:20.589859499Z    -> 0.0065s
2025-07-22T13:31:20.589867636Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0147s) =======
2025-07-22T13:31:20.589875652Z 
2025-07-22T13:31:20.589883337Z Migrating to CreateFederailsActors (20240731165647)
2025-07-22T13:31:20.589891273Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-07-22T13:31:20.589899279Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-07-22T13:31:20.589907356Z 
2025-07-22T13:31:20.589915051Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-07-22T13:31:20.589923087Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-07-22T13:31:20.589931074Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-07-22T13:31:20.589939100Z 
2025-07-22T13:31:20.589946925Z Migrating to BackfillActivities (20240805111500)
2025-07-22T13:31:20.589957006Z == 20240805111500 BackfillActivities: migrating ===============================
2025-07-22T13:31:20.589965042Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-07-22T13:31:20.589973489Z 
2025-07-22T13:31:20.589981665Z Migrating to CreateCaberRelations (20240827155630)
2025-07-22T13:31:20.589990213Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-07-22T13:31:20.589998249Z -- create_table(:caber_relations)
2025-07-22T13:31:20.590006185Z    -> 0.0056s
2025-07-22T13:31:20.590014031Z == 20240827155630 CreateCaberRelations: migrated (0.0056s) ====================
2025-07-22T13:31:20.590022087Z 
2025-07-22T13:31:20.590029782Z Migrating to AddDefaultAccessControls (20240830121749)
2025-07-22T13:31:20.590037728Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-07-22T13:31:20.590045704Z == 20240830121749 AddDefaultAccessControls: migrated (0.0066s) ================
2025-07-22T13:31:20.590053811Z 
2025-07-22T13:31:20.590061506Z Migrating to RenameDefaultRoles (20240830151650)
2025-07-22T13:31:20.590069522Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-07-22T13:31:20.590077508Z == 20240830151650 RenameDefaultRoles: migrated (0.0076s) ======================
2025-07-22T13:31:20.590085535Z 
2025-07-22T13:31:20.590093230Z Migrating to AddPublicIDsToModels (20240904151944)
2025-07-22T13:31:20.590101186Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-07-22T13:31:20.590109222Z -- add_column(:models, :public_id, :string)
2025-07-22T13:31:20.590126577Z    -> 0.0007s
2025-07-22T13:31:20.590134533Z -- add_index(:models, :public_id)
2025-07-22T13:31:20.590142439Z    -> 0.0004s
2025-07-22T13:31:20.590150415Z -- add_column(:model_files, :public_id, :string)
2025-07-22T13:31:20.590158381Z    -> 0.0006s
2025-07-22T13:31:20.590166297Z -- add_index(:model_files, :public_id)
2025-07-22T13:31:20.590174183Z    -> 0.0001s
2025-07-22T13:31:20.590182119Z -- add_column(:problems, :public_id, :string)
2025-07-22T13:31:20.834039938Z    -> 0.0007s
2025-07-22T13:31:20.834080109Z -- add_index(:problems, :public_id)
2025-07-22T13:31:20.834089168Z    -> 0.0001s
2025-07-22T13:31:20.834097464Z -- add_column(:creators, :public_id, :string)
2025-07-22T13:31:20.834105741Z    -> 0.0006s
2025-07-22T13:31:20.834114268Z -- add_index(:creators, :public_id)
2025-07-22T13:31:20.834122565Z    -> 0.0001s
2025-07-22T13:31:20.834131343Z -- add_column(:collections, :public_id, :string)
2025-07-22T13:31:20.834139529Z    -> 0.0006s
2025-07-22T13:31:20.834147525Z -- add_index(:collections, :public_id)
2025-07-22T13:31:20.834155471Z    -> 0.0001s
2025-07-22T13:31:20.834163497Z -- add_column(:libraries, :public_id, :string)
2025-07-22T13:31:20.834171664Z    -> 0.0006s
2025-07-22T13:31:20.834179900Z -- add_index(:libraries, :public_id)
2025-07-22T13:31:20.834188017Z    -> 0.0001s
2025-07-22T13:31:20.834196464Z == 20240904151944 AddPublicIDsToModels: migrated (0.0051s) ====================
2025-07-22T13:31:20.834204520Z 
2025-07-22T13:31:20.834212326Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-07-22T13:31:20.834220482Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-07-22T13:31:20.834228939Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:20.834237446Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0189s) ==============
2025-07-22T13:31:20.834245512Z 
2025-07-22T13:31:20.834253909Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-07-22T13:31:20.834262176Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-07-22T13:31:20.834270372Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-07-22T13:31:20.834278579Z 
2025-07-22T13:31:20.834286345Z Migrating to DeduplicateRoles (20240923114515)
2025-07-22T13:31:20.834294491Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-07-22T13:31:20.834302637Z == 20240923114515 DeduplicateRoles: migrated (0.0034s) ========================
2025-07-22T13:31:20.834330714Z 
2025-07-22T13:31:20.834338590Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-07-22T13:31:20.834347037Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-07-22T13:31:20.834355093Z -- add_column(:models, :name_lower, :virtual, {:type=>:string, :as=>"LOWER(name)", :stored=>true})
2025-07-22T13:31:20.834364081Z    -> 0.0182s
2025-07-22T13:31:20.834373781Z -- add_index(:models, :name_lower)
2025-07-22T13:31:20.834383741Z    -> 0.0002s
2025-07-22T13:31:20.834393631Z -- add_column(:creators, :name_lower, :virtual, {:type=>:string, :as=>"LOWER(name)", :stored=>true})
2025-07-22T13:31:20.834404182Z    -> 0.0071s
2025-07-22T13:31:20.834412429Z -- add_index(:creators, :name_lower)
2025-07-22T13:31:20.834420685Z    -> 0.0001s
2025-07-22T13:31:20.834428801Z -- add_column(:collections, :name_lower, :virtual, {:type=>:string, :as=>"LOWER(name)", :stored=>true})
2025-07-22T13:31:20.834437900Z    -> 0.0080s
2025-07-22T13:31:20.834445856Z -- add_index(:collections, :name_lower)
2025-07-22T13:31:20.834454283Z    -> 0.0001s
2025-07-22T13:31:20.834462780Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.0338s) =============
2025-07-22T13:31:20.834473191Z 
2025-07-22T13:31:20.834482920Z Migrating to AddKeypairToActors (20240926162407)
2025-07-22T13:31:20.834492450Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-07-22T13:31:20.834501879Z -- change_table(:federails_actors)
2025-07-22T13:31:20.834509895Z    -> 0.0015s
2025-07-22T13:31:20.834518262Z == 20240926162407 AddKeypairToActors: migrated (0.0015s) ======================
2025-07-22T13:31:20.834526288Z 
2025-07-22T13:31:20.834533973Z Migrating to AddUuids (20241004194445)
2025-07-22T13:31:20.834542360Z == 20241004194445 AddUuids: migrating =========================================
2025-07-22T13:31:20.834551158Z -- change_table(:federails_actors)
2025-07-22T13:31:20.834561408Z    -> 0.0013s
2025-07-22T13:31:20.834573874Z -- change_table(:federails_activities)
2025-07-22T13:31:20.834582030Z    -> 0.0008s
2025-07-22T13:31:20.834589936Z -- change_table(:federails_followings)
2025-07-22T13:31:20.834597822Z    -> 0.0008s
2025-07-22T13:31:20.834605617Z == 20241004194445 AddUuids: migrated (0.0030s) ================================
2025-07-22T13:31:20.834613664Z 
2025-07-22T13:31:20.834621339Z Migrating to CreateComments (20241007182824)
2025-07-22T13:31:20.834629516Z == 20241007182824 CreateComments: migrating ===================================
2025-07-22T13:31:20.834637512Z -- create_table(:comments)
2025-07-22T13:31:20.834656219Z    -> 0.0011s
2025-07-22T13:31:20.834664616Z == 20241007182824 CreateComments: migrated (0.0011s) ==========================
2025-07-22T13:31:20.834672883Z 
2025-07-22T13:31:20.834680819Z Migrating to AddSystemToComments (20241009122540)
2025-07-22T13:31:20.834688855Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-07-22T13:31:20.834696831Z -- add_column(:comments, :system, :boolean, {:null=>false, :default=>false})
2025-07-22T13:31:20.834705218Z    -> 0.0008s
2025-07-22T13:31:20.834713084Z == 20241009122540 AddSystemToComments: migrated (0.0008s) =====================
2025-07-22T13:31:20.834721130Z 
2025-07-22T13:31:20.834729327Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-07-22T13:31:20.834738114Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-07-22T13:31:20.834746140Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0014s) ============
2025-07-22T13:31:20.834754157Z 
2025-07-22T13:31:20.834761802Z Migrating to AddOmniauthToUsers (20241015090803)
2025-07-22T13:31:20.834769748Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-07-22T13:31:20.834777774Z -- add_column(:users, :auth_provider, :string)
2025-07-22T13:31:20.834785690Z    -> 0.0007s
2025-07-22T13:31:20.834793516Z -- add_column(:users, :auth_uid, :string)
2025-07-22T13:31:20.834801402Z    -> 0.0007s
2025-07-22T13:31:20.834809298Z == 20241015090803 AddOmniauthToUsers: migrated (0.0014s) ======================
2025-07-22T13:31:20.834817634Z 
2025-07-22T13:31:20.834825290Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-07-22T13:31:20.834833316Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-07-22T13:31:20.834841312Z -- add_column(:models, :sensitive, :boolean, {:null=>false, :default=>false})
2025-07-22T13:31:20.834849479Z    -> 0.0007s
2025-07-22T13:31:20.834857304Z -- add_column(:comments, :sensitive, :boolean, {:null=>false, :default=>false})
2025-07-22T13:31:20.834865451Z    -> 0.0007s
2025-07-22T13:31:20.834873266Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0014s) =====
2025-07-22T13:31:20.834881273Z 
2025-07-22T13:31:20.834889379Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-07-22T13:31:20.834897936Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-07-22T13:31:20.834905942Z -- add_column(:users, :sensitive_content_handling, :string, {:default=>nil})
2025-07-22T13:31:20.834914269Z    -> 0.0009s
2025-07-22T13:31:20.834922055Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0010s) ======
2025-07-22T13:31:20.835126506Z 
2025-07-22T13:31:20.835136166Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-07-22T13:31:20.835144242Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-07-22T13:31:20.835152288Z -- change_table(:users)
2025-07-22T13:31:20.835160565Z    -> 0.0009s
2025-07-22T13:31:20.835168411Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0009s) =====================
2025-07-22T13:31:20.835176747Z 
2025-07-22T13:31:20.835186317Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-07-22T13:31:20.835196948Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-07-22T13:31:20.835207249Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0027s) =================
2025-07-22T13:31:20.835216788Z 
2025-07-22T13:31:20.835224854Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-07-22T13:31:20.835234935Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-07-22T13:31:20.835243372Z -- remove_index(:favorites, {:name=>"index_favorites_on_favoritable", :column=>[:favoritable_type, :favoritable_id]})
2025-07-22T13:31:20.835252079Z    -> 0.0013s
2025-07-22T13:31:20.835260747Z -- remove_index(:federails_followings, {:name=>"index_federails_followings_on_actor_id", :column=>:actor_id})
2025-07-22T13:31:20.835269614Z    -> 0.0006s
2025-07-22T13:31:20.835279564Z -- remove_index(:roles, {:name=>"index_roles_on_name", :column=>:name})
2025-07-22T13:31:20.835290166Z    -> 0.0005s
2025-07-22T13:31:20.835300637Z -- remove_index(:taggings, {:name=>"index_taggings_on_tag_id", :column=>:tag_id})
2025-07-22T13:31:20.835309485Z    -> 0.0009s
2025-07-22T13:31:20.835317551Z -- remove_index(:taggings, {:name=>"index_taggings_on_taggable_id", :column=>:taggable_id})
2025-07-22T13:31:20.835326218Z    -> 0.0013s
2025-07-22T13:31:20.835334084Z -- remove_index(:taggings, {:name=>"index_taggings_on_tagger_id", :column=>:tagger_id})
2025-07-22T13:31:20.835342381Z    -> 0.0007s
2025-07-22T13:31:20.835350247Z -- remove_index(:users_roles, {:name=>"index_users_roles_on_user_id", :column=>:user_id})
2025-07-22T13:31:20.835359445Z    -> 0.0004s
2025-07-22T13:31:20.835369155Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0059s) ===================
2025-07-22T13:31:20.835379546Z 
2025-07-22T13:31:20.835388344Z Migrating to AddInProgressToProblems (20241105121830)
2025-07-22T13:31:20.835397021Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-07-22T13:31:20.835405187Z -- add_column(:problems, :in_progress, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:20.835424877Z    -> 0.0008s
2025-07-22T13:31:20.835432853Z == 20241105121830 AddInProgressToProblems: migrated (0.0008s) =================
2025-07-22T13:31:20.835440979Z 
2025-07-22T13:31:20.835448705Z Migrating to ClearStuckProblems (20241118155027)
2025-07-22T13:31:20.835458214Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-07-22T13:31:20.835466571Z == 20241118155027 ClearStuckProblems: migrated (0.0059s) ======================
2025-07-22T13:31:20.835474597Z 
2025-07-22T13:31:20.835482323Z Migrating to AddApprovedToUser (20241122121621)
2025-07-22T13:31:20.835490309Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-07-22T13:31:20.835498305Z -- change_table(:users)
2025-07-22T13:31:20.835506111Z    -> 0.0017s
2025-07-22T13:31:20.835513926Z == 20241122121621 AddApprovedToUser: migrated (0.0017s) =======================
2025-07-22T13:31:20.835522283Z 
2025-07-22T13:31:20.835530009Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-07-22T13:31:20.835538035Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-07-22T13:31:20.835546031Z -- create_table(:federails_moderation_reports)
2025-07-22T13:31:20.835555049Z    -> 0.0011s
2025-07-22T13:31:20.835563717Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0011s) ========
2025-07-22T13:31:20.835572164Z 
2025-07-22T13:31:20.835579879Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-07-22T13:31:20.835588206Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-07-22T13:31:20.835596633Z -- create_table(:federails_moderation_domain_blocks)
2025-07-22T13:31:20.835604779Z    -> 0.0004s
2025-07-22T13:31:20.835612615Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-07-22T13:31:20.835620782Z 
2025-07-22T13:31:20.835628447Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-07-22T13:31:20.835636964Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-07-22T13:31:20.835645010Z -- change_column_null(:comments, :commenter_id, true)
2025-07-22T13:31:20.835653387Z    -> 0.0103s
2025-07-22T13:31:20.835662796Z -- change_column_null(:comments, :commenter_type, true)
2025-07-22T13:31:20.835670792Z    -> 0.0080s
2025-07-22T13:31:20.835678618Z -- add_column(:comments, :federated_url, :string, {:null=>true, :default=>nil})
2025-07-22T13:31:20.835686885Z    -> 0.0007s
2025-07-22T13:31:20.835694971Z -- add_reference(:comments, :federails_actor, {:null=>true, :foreign_key=>true})
2025-07-22T13:31:20.835703618Z    -> 0.0103s
2025-07-22T13:31:20.835721324Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0297s) =======
2025-07-22T13:31:20.835729811Z 
2025-07-22T13:31:20.835737927Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-07-22T13:31:20.835746144Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-07-22T13:31:20.835754160Z -- add_column(:libraries, :s3_path_style, :boolean, {:default=>true, :null=>false})
2025-07-22T13:31:20.835762737Z    -> 0.0008s
2025-07-22T13:31:20.835770774Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0008s) =================
2025-07-22T13:31:20.835778860Z 
2025-07-22T13:31:20.835786625Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-07-22T13:31:20.835794662Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-07-22T13:31:21.149468846Z == 20250121164452 MakePublicIDsLowercase: migrated (0.0222s) ==================
2025-07-22T13:31:21.149506842Z 
2025-07-22T13:31:21.149516111Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-07-22T13:31:21.149524287Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-07-22T13:31:21.149532444Z -- add_column(:federails_actors, :extensions, :json, {:default=>nil, :null=>true})
2025-07-22T13:31:21.149540830Z    -> 0.0015s
2025-07-22T13:31:21.149548907Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0016s) ==========
2025-07-22T13:31:21.149557003Z 
2025-07-22T13:31:21.149564688Z Migrating to AddCreatorToCollections (20250222000000)
2025-07-22T13:31:21.149572574Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-07-22T13:31:21.149580490Z -- add_reference(:collections, :creator, {:null=>true, :foreign_key=>true})
2025-07-22T13:31:21.149588797Z    -> 0.0168s
2025-07-22T13:31:21.149596693Z == 20250222000000 AddCreatorToCollections: migrated (0.0168s) =================
2025-07-22T13:31:21.149604609Z 
2025-07-22T13:31:21.149612294Z Migrating to AddLocalToActors (20250305171530)
2025-07-22T13:31:21.149620120Z == 20250305171530 AddLocalToActors: migrating =================================
2025-07-22T13:31:21.149627996Z -- add_column(:federails_actors, :local, :boolean, {:null=>false, :default=>false})
2025-07-22T13:31:21.149636172Z    -> 0.0008s
2025-07-22T13:31:21.149643898Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-07-22T13:31:21.149652135Z    -> 0.0004s
2025-07-22T13:31:21.149660411Z    -> 0 rows
2025-07-22T13:31:21.149668297Z == 20250305171530 AddLocalToActors: migrated (0.0017s) ========================
2025-07-22T13:31:21.149676754Z 
2025-07-22T13:31:21.149684650Z Migrating to AddActorTypeToActors (20250407160721)
2025-07-22T13:31:21.149722556Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-07-22T13:31:21.149730853Z -- add_column(:federails_actors, :actor_type, :string, {:null=>true})
2025-07-22T13:31:21.149738899Z    -> 0.0008s
2025-07-22T13:31:21.149746956Z == 20250407160721 AddActorTypeToActors: migrated (0.0008s) ====================
2025-07-22T13:31:21.149755152Z 
2025-07-22T13:31:21.149762707Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-07-22T13:31:21.149770643Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-07-22T13:31:21.149778469Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {:default=>nil})
2025-07-22T13:31:21.149786485Z    -> 0.0010s
2025-07-22T13:31:21.149794191Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0011s) =================
2025-07-22T13:31:21.149802137Z 
2025-07-22T13:31:21.149809682Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-07-22T13:31:21.149817457Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-07-22T13:31:21.149825323Z -- create_table(:oauth_applications)
2025-07-22T13:31:21.149833249Z    -> 0.0004s
2025-07-22T13:31:21.149840995Z -- add_index(:oauth_applications, :uid, {:unique=>true})
2025-07-22T13:31:21.149849221Z    -> 0.0001s
2025-07-22T13:31:21.149856937Z -- create_table(:oauth_access_grants)
2025-07-22T13:31:21.149864683Z    -> 0.0006s
2025-07-22T13:31:21.149872679Z -- add_index(:oauth_access_grants, :token, {:unique=>true})
2025-07-22T13:31:21.149880795Z    -> 0.0001s
2025-07-22T13:31:21.149890254Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {:column=>:application_id})
2025-07-22T13:31:21.149899152Z    -> 0.0130s
2025-07-22T13:31:21.149907529Z -- create_table(:oauth_access_tokens)
2025-07-22T13:31:21.149916226Z    -> 0.0007s
2025-07-22T13:31:21.149924283Z -- add_index(:oauth_access_tokens, :token, {:unique=>true})
2025-07-22T13:31:21.149932409Z    -> 0.0002s
2025-07-22T13:31:21.149940405Z -- add_index(:oauth_access_tokens, :refresh_token, {:unique=>true})
2025-07-22T13:31:21.149949503Z    -> 0.0002s
2025-07-22T13:31:21.149957800Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {:column=>:application_id})
2025-07-22T13:31:21.149966668Z    -> 0.0097s
2025-07-22T13:31:21.149974814Z -- add_foreign_key(:oauth_access_grants, :users, {:column=>:resource_owner_id})
2025-07-22T13:31:21.149983712Z    -> 0.0079s
2025-07-22T13:31:21.149992049Z -- add_foreign_key(:oauth_access_tokens, :users, {:column=>:resource_owner_id})
2025-07-22T13:31:21.150000566Z    -> 0.0095s
2025-07-22T13:31:21.150223766Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0430s) ==================
2025-07-22T13:31:21.150233986Z 
2025-07-22T13:31:21.150241612Z Migrating to AddOwnerToApplication (20250408145956)
2025-07-22T13:31:21.150249968Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-07-22T13:31:21.150257995Z -- add_column(:oauth_applications, :owner_id, :bigint, {:null=>true})
2025-07-22T13:31:21.150265971Z    -> 0.0009s
2025-07-22T13:31:21.150273666Z -- add_column(:oauth_applications, :owner_type, :string, {:null=>true})
2025-07-22T13:31:21.150281612Z    -> 0.0007s
2025-07-22T13:31:21.150289428Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-07-22T13:31:21.150297264Z    -> 0.0002s
2025-07-22T13:31:21.150304979Z == 20250408145956 AddOwnerToApplication: migrated (0.0021s) ===================
2025-07-22T13:31:21.150313096Z 
2025-07-22T13:31:21.150320641Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-07-22T13:31:21.150328456Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-07-22T13:31:21.150336342Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-07-22T13:31:21.150344178Z    -> 0.0110s
2025-07-22T13:31:21.150351864Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0113s) ============
2025-07-22T13:31:21.150359749Z 
2025-07-22T13:31:21.150367315Z Migrating to AddQuotaToUsers (20250409125753)
2025-07-22T13:31:21.150375150Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-07-22T13:31:21.150383066Z -- add_column(:users, :quota, :integer, {:default=>1, :null=>false})
2025-07-22T13:31:21.150391313Z    -> 0.0009s
2025-07-22T13:31:21.150399209Z -- add_column(:users, :quota_use_site_default, :boolean, {:default=>true, :null=>false})
2025-07-22T13:31:21.150407365Z    -> 0.0008s
2025-07-22T13:31:21.150415031Z == 20250409125753 AddQuotaToUsers: migrated (0.0018s) =========================
2025-07-22T13:31:21.150422937Z 
2025-07-22T13:31:21.150430752Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-07-22T13:31:21.150439029Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-07-22T13:31:21.150447867Z -- add_column(:model_files, :filename_lower, :virtual, {:type=>:string, :as=>"LOWER(filename)", :stored=>true})
2025-07-22T13:31:21.150456745Z    -> 0.0134s
2025-07-22T13:31:21.150464490Z -- add_index(:model_files, :filename_lower)
2025-07-22T13:31:21.150472456Z    -> 0.0001s
2025-07-22T13:31:21.150480603Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0139s) 
2025-07-22T13:31:21.150499290Z 
2025-07-22T13:31:21.150507026Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-07-22T13:31:21.150515243Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-07-22T13:31:21.150523138Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-07-22T13:31:21.150531014Z    -> 0.0002s
2025-07-22T13:31:21.150539271Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0004s) ===================
2025-07-22T13:31:21.150547768Z 
2025-07-22T13:31:21.150555403Z Migrating to AddPreviewToModelFile (20250520111046)
2025-07-22T13:31:21.150563219Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-07-22T13:31:21.150571125Z -- add_column(:model_files, :previewable, :boolean, {:default=>false, :null=>false})
2025-07-22T13:31:21.150579773Z    -> 0.0010s
2025-07-22T13:31:21.150587538Z == 20250520111046 AddPreviewToModelFile: migrated (0.0011s) ===================
2025-07-22T13:31:21.150595434Z 
2025-07-22T13:31:21.150603019Z Migrating to CreateAltchaSolutions (20250609210440)
2025-07-22T13:31:21.150610835Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-07-22T13:31:21.150618691Z -- create_table(:altcha_solutions)
2025-07-22T13:31:21.150626436Z    -> 0.0004s
2025-07-22T13:31:21.150634262Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {:unique=>true, :name=>"index_altcha_solutions"})
2025-07-22T13:31:21.150643371Z    -> 0.0002s
2025-07-22T13:31:21.150651297Z == 20250609210440 CreateAltchaSolutions: migrated (0.0008s) ===================
2025-07-22T13:31:21.150659994Z 
2025-07-22T13:31:21.150668150Z Migrating to AddIndexableFields (20250620141805)
2025-07-22T13:31:21.150676257Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-07-22T13:31:21.150684624Z -- change_table(:models)
2025-07-22T13:31:21.150693201Z    -> 0.0018s
2025-07-22T13:31:21.150701748Z -- change_table(:creators)
2025-07-22T13:31:21.150710115Z    -> 0.0016s
2025-07-22T13:31:21.150718171Z -- change_table(:collections)
2025-07-22T13:31:21.150726217Z    -> 0.0016s
2025-07-22T13:31:21.150734474Z == 20250620141805 AddIndexableFields: migrated (0.0050s) ======================
2025-07-22T13:31:21.150742901Z 
2025-07-22T13:31:21.150750797Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-07-22T13:31:21.150759244Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-07-22T13:31:21.150767420Z -- change_column(:models, :indexable, :string)
2025-07-22T13:31:21.150775587Z    -> 0.0225s
2025-07-22T13:31:21.150783773Z -- change_column(:models, :ai_indexable, :string)
2025-07-22T13:31:21.150801339Z    -> 0.0187s
2025-07-22T13:31:21.150809265Z -- change_column(:creators, :indexable, :string)
2025-07-22T13:31:21.150817211Z    -> 0.0091s
2025-07-22T13:31:21.150824926Z -- change_column(:creators, :ai_indexable, :string)
2025-07-22T13:31:21.150832992Z    -> 0.0090s
2025-07-22T13:31:21.150840688Z -- change_column(:collections, :indexable, :string)
2025-07-22T13:31:21.150849225Z    -> 0.0174s
2025-07-22T13:31:21.150857482Z -- change_column(:collections, :ai_indexable, :string)
2025-07-22T13:31:21.150865348Z    -> 0.0144s
2025-07-22T13:31:21.150873093Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.0914s) ======
2025-07-22T13:31:21.150881270Z 
2025-07-22T13:31:21.150888895Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-07-22T13:31:21.150896801Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-07-22T13:31:21.150904727Z -- change_table(:models)
2025-07-22T13:31:21.150912683Z    -> 0.0003s
2025-07-22T13:31:21.150920398Z -- change_table(:creators)
2025-07-22T13:31:21.150928374Z    -> 0.0002s
2025-07-22T13:31:21.150936391Z -- change_table(:collections)
2025-07-22T13:31:21.150944106Z    -> 0.0002s
2025-07-22T13:31:21.150951872Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0009s) =================
2025-07-22T13:31:21.150959828Z 
2025-07-22T13:31:21.150967714Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-07-22T13:31:21.150976020Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-07-22T13:31:21.150983926Z -- change_table(:links)
2025-07-22T13:31:21.150991612Z    -> 0.0002s
2025-07-22T13:31:21.150999428Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-07-22T13:31:21.151007384Z 
2025-07-22T13:31:21.378272001Z s6-rc: info: service init-manyfold-config successfully started
2025-07-22T13:31:21.378600873Z s6-rc: info: service init-config-end: starting
2025-07-22T13:31:21.382324160Z s6-rc: info: service init-config-end successfully started
2025-07-22T13:31:21.382588643Z s6-rc: info: service init-mods: starting
2025-07-22T13:31:21.387361614Z s6-rc: info: service init-mods successfully started
2025-07-22T13:31:21.387541346Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-07-22T13:31:21.396160551Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-07-22T13:31:21.396410184Z s6-rc: info: service init-mods-package-install: starting
2025-07-22T13:31:21.408758098Z [pkg-install-init] **** Installing all mod packages ****
2025-07-22T13:31:21.418589255Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.21/main/x86_64/APKINDEX.tar.gz
2025-07-22T13:31:21.670910396Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.21/community/x86_64/APKINDEX.tar.gz
2025-07-22T13:31:22.011809841Z (1/1) Installing redis (7.2.9-r0)
2025-07-22T13:31:22.021564022Z Executing redis-7.2.9-r0.pre-install
2025-07-22T13:31:22.318182392Z Executing redis-7.2.9-r0.post-install
2025-07-22T13:31:22.326658870Z Executing busybox-1.37.0-r12.trigger
2025-07-22T13:31:22.339917989Z OK: 340 MiB in 91 packages
2025-07-22T13:31:22.430853259Z s6-rc: info: service init-mods-package-install successfully started
2025-07-22T13:31:22.431094205Z s6-rc: info: service init-mods-end: starting
2025-07-22T13:31:22.436802268Z s6-rc: info: service init-mods-end successfully started
2025-07-22T13:31:22.437053174Z s6-rc: info: service init-custom-files: starting
2025-07-22T13:31:22.443968979Z [custom-init] No custom files found, skipping...
2025-07-22T13:31:22.455083400Z s6-rc: info: service init-custom-files successfully started
2025-07-22T13:31:22.455230496Z s6-rc: info: service init-services: starting
2025-07-22T13:31:22.456878685Z s6-rc: info: service init-services successfully started
2025-07-22T13:31:22.457226345Z s6-rc: info: service svc-mod-universal-redis: starting
2025-07-22T13:31:22.457497381Z s6-rc: info: service svc-manyfold: starting
2025-07-22T13:31:22.457846333Z s6-rc: info: service svc-cron: starting
2025-07-22T13:31:22.467499982Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-07-22T13:31:22.472528638Z s6-rc: info: service svc-cron successfully started
2025-07-22T13:31:22.476711110Z 251:C 22 Jul 2025 13:31:22.476 # WARNING Memory overcommit must be enabled! Without it, a background save or replication may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
2025-07-22T13:31:22.476797484Z 251:C 22 Jul 2025 13:31:22.476 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-07-22T13:31:22.476805229Z 251:C 22 Jul 2025 13:31:22.476 * Redis version=7.2.9, bits=64, commit=00000000, modified=0, pid=251, just started
2025-07-22T13:31:22.476812053Z 251:C 22 Jul 2025 13:31:22.476 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-07-22T13:31:22.477863300Z 251:M 22 Jul 2025 13:31:22.477 * monotonic clock: POSIX clock_gettime
2025-07-22T13:31:22.478711538Z 251:M 22 Jul 2025 13:31:22.478 * Running mode=standalone, port=6379.
2025-07-22T13:31:22.478987864Z 251:M 22 Jul 2025 13:31:22.478 * Server initialized
2025-07-22T13:31:22.479045220Z 251:M 22 Jul 2025 13:31:22.479 * Ready to accept connections tcp
2025-07-22T13:31:22.716466018Z 13:31:22 rails.1              | started with pid 269
2025-07-22T13:31:22.716504906Z 13:31:22 default_worker.1     | started with pid 270
2025-07-22T13:31:22.716536870Z 13:31:22 performance_worker.1 | started with pid 271
2025-07-22T13:31:24.082605316Z 13:31:24 rails.1              | `/root` is not writable.
2025-07-22T13:31:24.082708463Z 13:31:24 rails.1              | Bundler will use `/tmp/bundler20250722-269-pkupiw269' as your home directory temporarily.
2025-07-22T13:31:24.546965114Z 13:31:24 default_worker.1     | `/root` is not writable.
2025-07-22T13:31:24.547026167Z 13:31:24 default_worker.1     | Bundler will use `/tmp/bundler20250722-270-rql2h4270' as your home directory temporarily.
2025-07-22T13:31:24.549773860Z 13:31:24 performance_worker.1 | `/root` is not writable.
2025-07-22T13:31:24.549888761Z 13:31:24 performance_worker.1 | Bundler will use `/tmp/bundler20250722-271-ggj55p271' as your home directory temporarily.
2025-07-22T13:31:25.463458903Z 13:31:25 rails.1              | => Booting Puma
2025-07-22T13:31:25.463493763Z 13:31:25 rails.1              | => Rails 8.0.2 application starting in production 
2025-07-22T13:31:25.463623163Z 13:31:25 rails.1              | => Run `bin/rails server --help` for more startup options
2025-07-22T13:31:25.913809231Z 13:31:25 rails.1              | Server: 4f047f08dc84, Context: rails, Role: web, data: {:cpu=>{:one_min=>2.06, :five_min=>1.63, :fifteen_min=>2.02}, :memory=>0.18003968e9, :disk=>{:available=>860916842496, :total=>938656133120, :used=>77739290624}}
2025-07-22T13:31:26.070757908Z 13:31:26 performance_worker.1 | Server: 4f047f08dc84, Context: rails, Role: web, data: {:cpu=>{:one_min=>2.06, :five_min=>1.63, :fifteen_min=>2.02}, :memory=>0.18223104e9, :disk=>{:available=>860895711232, :total=>938656133120, :used=>77760421888}}
2025-07-22T13:31:26.075269562Z 13:31:26 default_worker.1     | Server: 4f047f08dc84, Context: rails, Role: web, data: {:cpu=>{:one_min=>2.06, :five_min=>1.63, :fifteen_min=>2.02}, :memory=>0.182460416e9, :disk=>{:available=>860895711232, :total=>938656133120, :used=>77760421888}}
2025-07-22T13:31:27.815395871Z 13:31:27 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:27.816145801Z 13:31:27 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:27.816846672Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.816Z pid=271 tid=5sj: Sidekiq 8.0.5 connecting to Redis with options {:size=>10, :pool_name=>"internal", :url=>nil}
2025-07-22T13:31:27.817168550Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.816Z pid=270 tid=5si: Sidekiq 8.0.5 connecting to Redis with options {:size=>10, :pool_name=>"internal", :url=>nil}
2025-07-22T13:31:27.820672756Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.820Z pid=270 tid=5si: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-07-22T13:31:27.820682987Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.820Z pid=271 tid=5sj: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-07-22T13:31:27.822198589Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.821Z pid=271 tid=5sj: Cron Jobs - added job with name clear-downloads in the namespace default
2025-07-22T13:31:27.822247998Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.822Z pid=270 tid=5si: Cron Jobs - added job with name clear-downloads in the namespace default
2025-07-22T13:31:27.888657212Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.888Z pid=271 tid=5sj: Booted Rails 8.0.2 application in production environment
2025-07-22T13:31:27.888672633Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.888Z pid=270 tid=5si: Booted Rails 8.0.2 application in production environment
2025-07-22T13:31:27.888738666Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.888Z pid=271 tid=5sj: Running in ruby 3.3.8 (2025-04-09 revision b200bad6cd) +YJIT [x86_64-linux-musl]
2025-07-22T13:31:27.888795029Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.888Z pid=270 tid=5si: Running in ruby 3.3.8 (2025-04-09 revision b200bad6cd) +YJIT [x86_64-linux-musl]
2025-07-22T13:31:27.888816813Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.888Z pid=271 tid=5sj: See LICENSE and the LGPL-3.0 for licensing details.
2025-07-22T13:31:27.888937686Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.888Z pid=270 tid=5si: See LICENSE and the LGPL-3.0 for licensing details.
2025-07-22T13:31:27.888974300Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.888Z pid=271 tid=5sj: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-07-22T13:31:27.888991455Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.888Z pid=270 tid=5si: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-07-22T13:31:27.890120007Z 13:31:27 performance_worker.1 | INFO  2025-07-22T13:31:27.889Z pid=271 tid=5sj: Sidekiq 8.0.5 connecting to Redis with options {:size=>1, :pool_name=>"default", :url=>nil}
2025-07-22T13:31:27.890166832Z 13:31:27 default_worker.1     | INFO  2025-07-22T13:31:27.889Z pid=270 tid=5si: Sidekiq 8.0.5 connecting to Redis with options {:size=>4, :pool_name=>"default", :url=>nil}
2025-07-22T13:31:28.030358315Z 13:31:28 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:28.030393035Z 13:31:28 rails.1              | INFO  2025-07-22T13:31:27.894Z pid=269 tid=5ix: Sidekiq 8.0.5 connecting to Redis with options {:size=>10, :pool_name=>"internal", :url=>nil}
2025-07-22T13:31:28.030399288Z 13:31:28 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: f5d41e57-6a4c-4f35-afed-3daeeb29693f) to Sidekiq(upgrade)
2025-07-22T13:31:28.030409639Z 13:31:28 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 2c8fae35-e7cd-4601-b017-9de529a86ea7) to Sidekiq(upgrade)
2025-07-22T13:31:28.030443627Z 13:31:28 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 33e39b6b-0341-46b4-a433-c374745272f2) to Sidekiq(upgrade)
2025-07-22T13:31:28.030529350Z 13:31:28 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: e0e25e97-3c9d-41b5-ba84-4d55cdbc8075) to Sidekiq(upgrade)
2025-07-22T13:31:28.030566555Z 13:31:28 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 3e970443-543b-426d-b16d-387c4eef988a) to Sidekiq(upgrade)
2025-07-22T13:31:28.030578930Z 13:31:28 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: 567d8905-8d25-4d84-aaf7-2b212e2ead83) to Sidekiq(upgrade)
2025-07-22T13:31:28.030626576Z 13:31:28 rails.1              | [269] Puma starting in cluster mode...
2025-07-22T13:31:28.030664171Z 13:31:28 rails.1              | [269] * Puma version: 6.6.0 ("Return to Forever")
2025-07-22T13:31:28.030708390Z 13:31:28 rails.1              | [269] * Ruby version: ruby 3.3.8 (2025-04-09 revision b200bad6cd) +YJIT [x86_64-linux-musl]
2025-07-22T13:31:28.030750595Z 13:31:28 rails.1              | [269] *  Min threads: 4
2025-07-22T13:31:28.030797139Z 13:31:28 rails.1              | [269] *  Max threads: 16
2025-07-22T13:31:28.030838492Z 13:31:28 rails.1              | [269] *  Environment: production
2025-07-22T13:31:28.031006551Z 13:31:28 rails.1              | [269] *   Master PID: 269
2025-07-22T13:31:28.031056451Z 13:31:28 rails.1              | [269] *      Workers: 4
2025-07-22T13:31:28.031103125Z 13:31:28 rails.1              | [269] *     Restarts: (✔) hot (✖) phased
2025-07-22T13:31:28.031147294Z 13:31:28 rails.1              | [269] * Preloading application
2025-07-22T13:31:28.031195311Z 13:31:28 rails.1              | [269] * Listening on http://[::]:3214
2025-07-22T13:31:28.031242115Z 13:31:28 rails.1              | [269] Use Ctrl-C to stop
2025-07-22T13:31:28.051834530Z 13:31:28 rails.1              | [269] - Worker 0 (PID: 313) booted in 0.01s, phase: 0
2025-07-22T13:31:28.051861244Z 13:31:28 rails.1              | [269] - Worker 1 (PID: 318) booted in 0.01s, phase: 0
2025-07-22T13:31:28.051896365Z 13:31:28 rails.1              | [269] - Worker 2 (PID: 337) booted in 0.01s, phase: 0
2025-07-22T13:31:28.053235652Z 13:31:28 rails.1              | [269] - Worker 3 (PID: 352) booted in 0.0s, phase: 0
2025-07-22T13:31:28.114091543Z 13:31:28 performance_worker.1 | Server: 4f047f08dc84, Context: sidekiq, Role: background, data: {:cpu=>{:one_min=>2.38, :five_min=>1.7, :fifteen_min=>2.04}, :memory=>0.211021824e9, :disk=>{:available=>860889792512, :total=>938656133120, :used=>77766340608}}
2025-07-22T13:31:28.117449355Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.117Z pid=270 tid=1i3i jid=e4bdaee5d13ebcdaaa3ced2b class=Upgrade::FixNilFileSizeValues: start
2025-07-22T13:31:28.118700093Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f5d41e57-6a4c-4f35-afed-3daeeb29693f] Performing Upgrade::FixNilFileSizeValues (Job ID: f5d41e57-6a4c-4f35-afed-3daeeb29693f) from Sidekiq(upgrade) enqueued at 2025-07-22T13:31:27.907248578Z
2025-07-22T13:31:28.119886001Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.118Z pid=270 tid=1hs6 jid=ef3791145bc74f993bfa5fc5 class=Upgrade::BackfillDataPackages: start
2025-07-22T13:31:28.121017189Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [2c8fae35-e7cd-4601-b017-9de529a86ea7] Performing Upgrade::BackfillDataPackages (Job ID: 2c8fae35-e7cd-4601-b017-9de529a86ea7) from Sidekiq(upgrade) enqueued at 2025-07-22T13:31:27.908280867Z
2025-07-22T13:31:28.121558920Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.118Z pid=270 tid=1hsi jid=1305572d1e929f958895ebd1 class=Upgrade::DisambiguateUsernamesJob: start
2025-07-22T13:31:28.122317477Z 13:31:28 default_worker.1     | Server: 4f047f08dc84, Context: sidekiq, Role: background, data: {:cpu=>{:one_min=>2.38, :five_min=>1.7, :fifteen_min=>2.04}, :memory=>0.210079744e9, :disk=>{:available=>860889792512, :total=>938656133120, :used=>77766340608}}
2025-07-22T13:31:28.122849839Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.118Z pid=270 tid=1htq jid=771a7a0cf7b541073a103eb9 class=Upgrade::UpdateActorsJob: start
2025-07-22T13:31:28.125347989Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [33e39b6b-0341-46b4-a433-c374745272f2] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 33e39b6b-0341-46b4-a433-c374745272f2) from Sidekiq(upgrade) enqueued at 2025-07-22T13:31:27.908888330Z
2025-07-22T13:31:28.125664787Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [e0e25e97-3c9d-41b5-ba84-4d55cdbc8075] Performing Upgrade::UpdateActorsJob (Job ID: e0e25e97-3c9d-41b5-ba84-4d55cdbc8075) from Sidekiq(upgrade) enqueued at 2025-07-22T13:31:27.909503529Z
2025-07-22T13:31:28.133286174Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [e0e25e97-3c9d-41b5-ba84-4d55cdbc8075] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:28.135855938Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [2c8fae35-e7cd-4601-b017-9de529a86ea7] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:28.140832630Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [33e39b6b-0341-46b4-a433-c374745272f2] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:28.211413603Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f5d41e57-6a4c-4f35-afed-3daeeb29693f] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:28.246824468Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f5d41e57-6a4c-4f35-afed-3daeeb29693f] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-07-22T13:31:28.248419319Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f5d41e57-6a4c-4f35-afed-3daeeb29693f] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.022
2025-07-22T13:31:28.264976429Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [e0e25e97-3c9d-41b5-ba84-4d55cdbc8075] Performed Upgrade::UpdateActorsJob (Job ID: e0e25e97-3c9d-41b5-ba84-4d55cdbc8075) from Sidekiq(upgrade) in 139.72ms
2025-07-22T13:31:28.269364325Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [2c8fae35-e7cd-4601-b017-9de529a86ea7] Performed Upgrade::BackfillDataPackages (Job ID: 2c8fae35-e7cd-4601-b017-9de529a86ea7) from Sidekiq(upgrade) in 148.3ms
2025-07-22T13:31:28.270522106Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.269Z pid=270 tid=1htq jid=771a7a0cf7b541073a103eb9 class=Upgrade::UpdateActorsJob elapsed=0.151: done
2025-07-22T13:31:28.270938956Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [33e39b6b-0341-46b4-a433-c374745272f2] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 33e39b6b-0341-46b4-a433-c374745272f2) from Sidekiq(upgrade) in 147.41ms
2025-07-22T13:31:28.272079182Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f5d41e57-6a4c-4f35-afed-3daeeb29693f] Performed Upgrade::FixNilFileSizeValues (Job ID: f5d41e57-6a4c-4f35-afed-3daeeb29693f) from Sidekiq(upgrade) in 153.47ms
2025-07-22T13:31:28.275469669Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.270Z pid=270 tid=1hs6 jid=ef3791145bc74f993bfa5fc5 class=Upgrade::BackfillDataPackages elapsed=0.152: done
2025-07-22T13:31:28.275649912Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.270Z pid=270 tid=1htq jid=c740215a9a1f9de8a9568f25 class=Upgrade::FixParentCollections: start
2025-07-22T13:31:28.276950180Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [3e970443-543b-426d-b16d-387c4eef988a] Performing Upgrade::FixParentCollections (Job ID: 3e970443-543b-426d-b16d-387c4eef988a) from Sidekiq(upgrade) enqueued at 2025-07-22T13:31:27.910105962Z
2025-07-22T13:31:28.277479596Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.276Z pid=270 tid=1hs6 jid=7e25ef2a3c4186d62786dab8 class=Upgrade::PruneOrphanedProblems: start
2025-07-22T13:31:28.277970264Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [567d8905-8d25-4d84-aaf7-2b212e2ead83] Performing Upgrade::PruneOrphanedProblems (Job ID: 567d8905-8d25-4d84-aaf7-2b212e2ead83) from Sidekiq(upgrade) enqueued at 2025-07-22T13:31:27.910736922Z
2025-07-22T13:31:28.278703570Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.276Z pid=270 tid=1i3i jid=e4bdaee5d13ebcdaaa3ced2b class=Upgrade::FixNilFileSizeValues elapsed=0.159: done
2025-07-22T13:31:28.279229760Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.274Z pid=270 tid=1hsi jid=1305572d1e929f958895ebd1 class=Upgrade::DisambiguateUsernamesJob elapsed=0.156: done
2025-07-22T13:31:28.280195514Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [3e970443-543b-426d-b16d-387c4eef988a] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:28.319062127Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [567d8905-8d25-4d84-aaf7-2b212e2ead83] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-07-22T13:31:28.422264639Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [567d8905-8d25-4d84-aaf7-2b212e2ead83] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-07-22T13:31:28.422422066Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [567d8905-8d25-4d84-aaf7-2b212e2ead83] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.068
2025-07-22T13:31:28.424687558Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [3e970443-543b-426d-b16d-387c4eef988a] Performed Upgrade::FixParentCollections (Job ID: 3e970443-543b-426d-b16d-387c4eef988a) from Sidekiq(upgrade) in 147.82ms
2025-07-22T13:31:28.437313662Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.436Z pid=270 tid=1htq jid=c740215a9a1f9de8a9568f25 class=Upgrade::FixParentCollections elapsed=0.166: done
2025-07-22T13:31:28.437459255Z 13:31:28 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [567d8905-8d25-4d84-aaf7-2b212e2ead83] Performed Upgrade::PruneOrphanedProblems (Job ID: 567d8905-8d25-4d84-aaf7-2b212e2ead83) from Sidekiq(upgrade) in 159.38ms
2025-07-22T13:31:28.438849214Z 13:31:28 default_worker.1     | INFO  2025-07-22T13:31:28.438Z pid=270 tid=1hs6 jid=7e25ef2a3c4186d62786dab8 class=Upgrade::PruneOrphanedProblems elapsed=0.162: done
2025-07-22T13:31:28.500046784Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-07-22T13:31:28.501454338Z s6-rc: info: service svc-manyfold successfully started
2025-07-22T13:31:28.501782709Z s6-rc: info: service legacy-services: starting
2025-07-22T13:31:28.514556621Z s6-rc: info: service legacy-services successfully started
2025-07-22T13:31:28.514843108Z s6-rc: info: service ci-service-check: starting
2025-07-22T13:31:28.518624452Z [ls.io-init] done.
2025-07-22T13:31:28.519759858Z s6-rc: info: service ci-service-check successfully started
2025-07-22T13:31:57.008810141Z 13:31:57 rails.1              | [68a7c1ac-de28-4500-977a-ebdd2e00a327] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1548,"duration":30.34,"view":0.0,"db":2.98,"@timestamp":"2025-07-22T13:31:57.007Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-07-22T13:31:57.580460130Z 13:31:57 rails.1              | [23f409d4-0a67-4067-862c-c6ec8d89cc92] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":79087,"duration":553.38,"view":0.0,"db":11.1,"location":"http://172.17.0.4:3214/","@timestamp":"2025-07-22T13:31:57.579Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-07-22T13:31:57.606775419Z 13:31:57 rails.1              | [46287ee8-f994-4946-b92b-ece2e5e16064] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1180,"duration":12.37,"view":0.0,"db":1.76,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-07-22T13:31:57.599Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-07-22T13:31:57.877278932Z 13:31:57 rails.1              | [4d1b9775-3ea0-4ba1-a95b-d1a54e221232] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":26509,"duration":260.78,"view":197.76,"db":24.32,"@timestamp":"2025-07-22T13:31:57.876Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-07-22T13:31:57.932992588Z 13:31:57 rails.1              | [6abd46c5-74a1-4b6c-8081-8e0d603aab45] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":2177,"duration":26.21,"view":0.0,"db":1.68,"@timestamp":"2025-07-22T13:31:57.931Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-07-22T13:31:58.054876446Z 13:31:58 rails.1              | [bc7953f5-f9e5-4095-9915-9fcece7217c9] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":15857,"duration":88.68,"view":0.0,"db":1.13,"location":"http://172.17.0.4:3214/","@timestamp":"2025-07-22T13:31:58.054Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-07-22T13:31:58.087576753Z 13:31:58 rails.1              | [313dfa27-a43a-45c0-b0ff-c6b2888fa74b] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1199,"duration":9.41,"view":0.0,"db":1.01,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-07-22T13:31:58.071Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-07-22T13:31:58.232815649Z 13:31:58 rails.1              | [aa342030-593a-4b16-8cfb-369b5a44f682] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":26645,"duration":132.51,"view":97.94,"db":1.05,"@timestamp":"2025-07-22T13:31:58.228Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}