2025-09-29T21:13:33.649094171Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-09-29T21:13:33.649147007Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-09-29T21:13:33.694937389Z [mod-init] Running Docker Modification Logic
2025-09-29T21:13:33.943317279Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-09-29T21:13:34.667742080Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-09-29T21:13:35.026691941Z [mod-init] Installing linuxserver/mods:universal-redis
2025-09-29T21:13:35.052161846Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-09-29T21:13:35.053198684Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-09-29T21:13:35.071813366Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-09-29T21:13:35.074779829Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-09-29T21:13:35.074952928Z s6-rc: info: service fix-attrs: starting
2025-09-29T21:13:35.075177490Z s6-rc: info: service init-migrations: starting
2025-09-29T21:13:35.075501312Z s6-rc: info: service init-envfile: starting
2025-09-29T21:13:35.082241043Z s6-rc: info: service init-envfile successfully started
2025-09-29T21:13:35.082627652Z s6-rc: info: service fix-attrs successfully started
2025-09-29T21:13:35.082761792Z s6-rc: info: service legacy-cont-init: starting
2025-09-29T21:13:35.083373213Z [migrations] started
2025-09-29T21:13:35.083482503Z [migrations] no migrations found
2025-09-29T21:13:35.083987981Z s6-rc: info: service init-migrations successfully started
2025-09-29T21:13:35.084138103Z s6-rc: info: service init-adduser: starting
2025-09-29T21:13:35.088496990Z s6-rc: info: service legacy-cont-init successfully started
2025-09-29T21:13:35.110816903Z usermod: no changes
2025-09-29T21:13:35.117541112Z ───────────────────────────────────────
2025-09-29T21:13:35.117567515Z 
2025-09-29T21:13:35.117576564Z       ██╗     ███████╗██╗ ██████╗
2025-09-29T21:13:35.117585462Z       ██║     ██╔════╝██║██╔═══██╗
2025-09-29T21:13:35.117593989Z       ██║     ███████╗██║██║   ██║
2025-09-29T21:13:35.117602486Z       ██║     ╚════██║██║██║   ██║
2025-09-29T21:13:35.117610963Z       ███████╗███████║██║╚██████╔╝
2025-09-29T21:13:35.117619711Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-09-29T21:13:35.117628428Z 
2025-09-29T21:13:35.117637076Z    Brought to you by linuxserver.io
2025-09-29T21:13:35.117677186Z ───────────────────────────────────────
2025-09-29T21:13:35.117948392Z 
2025-09-29T21:13:35.117972591Z To support LSIO projects visit:
2025-09-29T21:13:35.117982281Z https://www.linuxserver.io/donate/
2025-09-29T21:13:35.117990658Z 
2025-09-29T21:13:35.117999175Z ───────────────────────────────────────
2025-09-29T21:13:35.118008473Z GID/UID
2025-09-29T21:13:35.118016650Z ───────────────────────────────────────
2025-09-29T21:13:35.122411168Z 
2025-09-29T21:13:35.122447943Z User UID:    911
2025-09-29T21:13:35.122457933Z User GID:    911
2025-09-29T21:13:35.122467091Z ───────────────────────────────────────
2025-09-29T21:13:35.124250492Z Linuxserver.io version: v0.124.0-ls106
2025-09-29T21:13:35.124457008Z Build-date: 2025-09-29T21:02:06+00:00
2025-09-29T21:13:35.124479623Z ───────────────────────────────────────
2025-09-29T21:13:35.124489313Z     
2025-09-29T21:13:35.140864816Z s6-rc: info: service init-adduser successfully started
2025-09-29T21:13:35.140984016Z s6-rc: info: service init-device-perms: starting
2025-09-29T21:13:35.146133505Z s6-rc: info: service init-device-perms successfully started
2025-09-29T21:13:35.146347536Z s6-rc: info: service init-os-end: starting
2025-09-29T21:13:35.148052810Z s6-rc: info: service init-os-end successfully started
2025-09-29T21:13:35.148174014Z s6-rc: info: service init-manyfold-config: starting
2025-09-29T21:13:35.148292392Z s6-rc: info: service init-config: starting
2025-09-29T21:13:35.149469532Z s6-rc: info: service init-config successfully started
2025-09-29T21:13:35.149571808Z s6-rc: info: service init-crontab-config: starting
2025-09-29T21:13:35.158832576Z s6-rc: info: service init-crontab-config successfully started
2025-09-29T21:13:35.174429922Z **** Running Manyfold database init. ****
2025-09-29T21:13:37.485100200Z `/root` is not writable.
2025-09-29T21:13:37.485255803Z Bundler will use `/tmp/bundler20250929-173-gy6mqh173' as your home directory temporarily.
2025-09-29T21:13:44.518419756Z Server: 7f90fe5f0e2a, Context: rails, Role: web, data: {cpu: {one_min: 2.7, five_min: 2.54, fifteen_min: 2.19}, memory: 0.230182912e9, disk: {available: 831681392640, total: 938656133120, used: 106974740480}}
2025-09-29T21:13:44.518464646Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-09-29T21:13:44.518475258Z INFO  2025-09-29T21:13:42.536Z pid=173 tid=2il: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-29T21:13:44.518659058Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-09-29T21:13:44.518670170Z Migrating to CreateLibraries (20210130201037)
2025-09-29T21:13:44.518678497Z == 20210130201037 CreateLibraries: migrating ==================================
2025-09-29T21:13:44.518687004Z -- create_table(:libraries)
2025-09-29T21:13:44.518695511Z    -> 0.0027s
2025-09-29T21:13:44.518703738Z == 20210130201037 CreateLibraries: migrated (0.0027s) =========================
2025-09-29T21:13:44.518711904Z 
2025-09-29T21:13:44.518719750Z Migrating to CreateModels (20210130203243)
2025-09-29T21:13:44.518728357Z == 20210130203243 CreateModels: migrating =====================================
2025-09-29T21:13:44.518736434Z -- create_table(:models)
2025-09-29T21:13:44.518744650Z    -> 0.0010s
2025-09-29T21:13:44.518753097Z == 20210130203243 CreateModels: migrated (0.0010s) ============================
2025-09-29T21:13:44.518761534Z 
2025-09-29T21:13:44.518769651Z Migrating to CreateParts (20210205230918)
2025-09-29T21:13:44.518777577Z == 20210205230918 CreateParts: migrating ======================================
2025-09-29T21:13:44.518785653Z -- create_table(:parts)
2025-09-29T21:13:44.518793529Z    -> 0.0036s
2025-09-29T21:13:44.518801996Z == 20210205230918 CreateParts: migrated (0.0037s) =============================
2025-09-29T21:13:44.518810573Z 
2025-09-29T21:13:44.518818329Z Migrating to AddFieldsToParts (20210210153744)
2025-09-29T21:13:44.518826495Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-09-29T21:13:44.518834531Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-09-29T21:13:44.518842617Z    -> 0.0009s
2025-09-29T21:13:44.518850503Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-09-29T21:13:44.518858540Z    -> 0.0003s
2025-09-29T21:13:44.518866435Z == 20210210153744 AddFieldsToParts: migrated (0.0013s) ========================
2025-09-29T21:13:44.518874953Z 
2025-09-29T21:13:44.518882728Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-09-29T21:13:44.518891306Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-09-29T21:13:44.518899843Z -- create_table(:tags, {id: :integer})
2025-09-29T21:13:44.518907789Z    -> 0.0042s
2025-09-29T21:13:44.518915855Z -- create_table(:taggings, {id: :integer})
2025-09-29T21:13:44.518923941Z    -> 0.0021s
2025-09-29T21:13:44.518932007Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-29T21:13:44.518940304Z    -> 0.0003s
2025-09-29T21:13:44.518961747Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-29T21:13:44.518970916Z    -> 0.0027s
2025-09-29T21:13:44.518979313Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0095s) ===============
2025-09-29T21:13:44.518987399Z 
2025-09-29T21:13:44.518995676Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-09-29T21:13:44.519004253Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-09-29T21:13:44.519012580Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-09-29T21:13:44.519020866Z    -> 0.0004s
2025-09-29T21:13:44.519028742Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-29T21:13:44.519037149Z    -> 0.0005s
2025-09-29T21:13:44.519045055Z -- remove_foreign_key(:taggings, :tags)
2025-09-29T21:13:44.519053392Z    -> 0.1859s
2025-09-29T21:13:44.519061238Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-29T21:13:44.519069384Z    -> 0.0151s
2025-09-29T21:13:44.519077701Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-09-29T21:13:44.519086599Z    -> 0.0002s
2025-09-29T21:13:44.519094906Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-09-29T21:13:44.519103813Z    -> 0.0049s
2025-09-29T21:13:44.519111910Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-09-29T21:13:44.519120076Z    -> 0.0721s
2025-09-29T21:13:44.519128323Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3138s) =================
2025-09-29T21:13:44.519136760Z 
2025-09-29T21:13:44.519145006Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-09-29T21:13:44.519153043Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-09-29T21:13:44.519161670Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-09-29T21:13:44.519170377Z    -> 0.0367s
2025-09-29T21:13:44.519178504Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1173s) ===========
2025-09-29T21:13:44.519186941Z 
2025-09-29T21:13:44.519194837Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-09-29T21:13:44.519202903Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-09-29T21:13:44.519211089Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-29T21:13:44.519219466Z    -> 0.0003s
2025-09-29T21:13:44.519227362Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-09-29T21:13:44.519244978Z 
2025-09-29T21:13:44.519253124Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-09-29T21:13:44.519261401Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-09-29T21:13:44.519269417Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0007s) ==============
2025-09-29T21:13:44.519277824Z 
2025-09-29T21:13:44.519285579Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-09-29T21:13:44.519293606Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-09-29T21:13:44.519302123Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-29T21:13:44.519310430Z    -> 0.0083s
2025-09-29T21:13:44.519318335Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-29T21:13:44.519326472Z    -> 0.0002s
2025-09-29T21:13:44.519334328Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-29T21:13:44.519342584Z    -> 0.0060s
2025-09-29T21:13:44.519350450Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-29T21:13:44.519358647Z    -> 0.0012s
2025-09-29T21:13:44.519366522Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-29T21:13:44.519374959Z    -> 0.0004s
2025-09-29T21:13:44.519382825Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-29T21:13:44.519391002Z    -> 0.0001s
2025-09-29T21:13:44.519398908Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-29T21:13:44.519409178Z    -> 0.0039s
2025-09-29T21:13:44.519417235Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-29T21:13:44.519425471Z    -> 0.0001s
2025-09-29T21:13:44.519433397Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-29T21:13:44.519441744Z    -> 0.0005s
2025-09-29T21:13:44.519449760Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-29T21:13:44.519458217Z    -> 0.0001s
2025-09-29T21:13:44.519466213Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-29T21:13:44.519474620Z    -> 0.0006s
2025-09-29T21:13:44.519482516Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-29T21:13:44.519490883Z    -> 0.0001s
2025-09-29T21:13:44.519499029Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-29T21:13:44.519508428Z    -> 0.0016s
2025-09-29T21:13:44.519516815Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-29T21:13:44.519537216Z    -> 0.0001s
2025-09-29T21:13:44.519546505Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0237s) =============
2025-09-29T21:13:44.519555924Z 
2025-09-29T21:13:44.519565012Z Migrating to AddPreviewPartToModel (20210220204055)
2025-09-29T21:13:44.519574541Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-09-29T21:13:44.519583910Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-09-29T21:13:44.519594091Z    -> 0.2562s
2025-09-29T21:13:44.519603249Z == 20210220204055 AddPreviewPartToModel: migrated (0.2562s) ===================
2025-09-29T21:13:44.519612638Z 
2025-09-29T21:13:44.519621686Z Migrating to CreateCreators (20210225232756)
2025-09-29T21:13:44.519631055Z == 20210225232756 CreateCreators: migrating ===================================
2025-09-29T21:13:44.519640574Z -- create_table(:creators)
2025-09-29T21:13:44.519649823Z    -> 0.0143s
2025-09-29T21:13:44.519659302Z == 20210225232756 CreateCreators: migrated (0.0143s) ==========================
2025-09-29T21:13:44.519669382Z 
2025-09-29T21:13:44.519679483Z Migrating to AddCreatorToModels (20210225232841)
2025-09-29T21:13:44.519688841Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-09-29T21:13:44.519698341Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-09-29T21:13:44.519707309Z    -> 0.0569s
2025-09-29T21:13:44.519715245Z == 20210225232841 AddCreatorToModels: migrated (0.0569s) ======================
2025-09-29T21:13:44.519723581Z 
2025-09-29T21:13:44.519731347Z Migrating to CreateLinks (20210301230017)
2025-09-29T21:13:44.519739664Z == 20210301230017 CreateLinks: migrating ======================================
2025-09-29T21:13:44.519748121Z -- create_table(:links)
2025-09-29T21:13:44.519756327Z    -> 0.0010s
2025-09-29T21:13:44.519764213Z == 20210301230017 CreateLinks: migrated (0.0010s) =============================
2025-09-29T21:13:44.519772500Z 
2025-09-29T21:13:44.519780987Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-09-29T21:13:44.519789244Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-09-29T21:13:44.519797530Z -- remove_column(:creators, :thingiverse_user, :string)
2025-09-29T21:13:44.519806188Z    -> 0.0692s
2025-09-29T21:13:44.519814334Z -- remove_column(:creators, :cults3d_user, :string)
2025-09-29T21:13:44.519822551Z    -> 0.0043s
2025-09-29T21:13:44.519830617Z -- remove_column(:creators, :mmf_user, :string)
2025-09-29T21:13:44.519838793Z    -> 0.0132s
2025-09-29T21:13:44.519871299Z -- remove_column(:creators, :cgtrader_user, :string)
2025-09-29T21:13:44.519882361Z    -> 0.0035s
2025-09-29T21:13:44.519890327Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0923s) ==============
2025-09-29T21:13:44.519898744Z 
2025-09-29T21:13:44.519906470Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-09-29T21:13:44.519914546Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-09-29T21:13:44.519922973Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-09-29T21:13:44.519931370Z    -> 0.0552s
2025-09-29T21:13:44.519939316Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0553s) ==
2025-09-29T21:13:44.519947402Z 
2025-09-29T21:13:44.519955368Z Migrating to AddYUpToParts (20210318202638)
2025-09-29T21:13:44.519963745Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-09-29T21:13:44.519971781Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-09-29T21:13:44.519980068Z    -> 0.0147s
2025-09-29T21:13:44.519988114Z == 20210318202638 AddYUpToParts: migrated (0.0148s) ===========================
2025-09-29T21:13:44.519996170Z 
2025-09-29T21:13:44.520003976Z Migrating to CreateImages (20210321164508)
2025-09-29T21:13:44.520011912Z == 20210321164508 CreateImages: migrating =====================================
2025-09-29T21:13:44.520019988Z -- create_table(:images)
2025-09-29T21:13:44.520028034Z    -> 0.0156s
2025-09-29T21:13:44.520035930Z == 20210321164508 CreateImages: migrated (0.0157s) ============================
2025-09-29T21:13:44.520044017Z 
2025-09-29T21:13:44.520051802Z Migrating to CreateDelayedJobs (20210330215825)
2025-09-29T21:13:44.520059768Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-09-29T21:13:44.520067855Z -- create_table(:delayed_jobs)
2025-09-29T21:13:44.520075801Z    -> 0.0086s
2025-09-29T21:13:45.259213376Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-09-29T21:13:45.259253928Z    -> 0.0001s
2025-09-29T21:13:45.259264359Z == 20210330215825 CreateDelayedJobs: migrated (0.0089s) =======================
2025-09-29T21:13:45.259272846Z 
2025-09-29T21:13:45.259280782Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-09-29T21:13:45.259289209Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-09-29T21:13:45.259297716Z -- rename_table(:parts, :model_files)
2025-09-29T21:13:45.259305953Z    -> 0.0017s
2025-09-29T21:13:45.259314380Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-09-29T21:13:45.259347907Z    -> 0.0329s
2025-09-29T21:13:45.259356274Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0347s) =================
2025-09-29T21:13:45.259364431Z 
2025-09-29T21:13:45.259372286Z Migrating to RemoveImagesTable (20220106220519)
2025-09-29T21:13:45.259380292Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-09-29T21:13:45.259388419Z -- drop_table(:images)
2025-09-29T21:13:45.259397207Z    -> 0.0003s
2025-09-29T21:13:45.259405443Z == 20220106220519 RemoveImagesTable: migrated (0.0003s) =======================
2025-09-29T21:13:45.259413640Z 
2025-09-29T21:13:45.259421736Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-09-29T21:13:45.259429782Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-09-29T21:13:45.259437848Z -- table_exists?(:active_storage_blobs)
2025-09-29T21:13:45.259445824Z    -> 0.0001s
2025-09-29T21:13:45.259453710Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-09-29T21:13:45.259461787Z 
2025-09-29T21:13:45.259469632Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-09-29T21:13:45.259477659Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-09-29T21:13:45.259485725Z -- table_exists?(:active_storage_blobs)
2025-09-29T21:13:45.259493681Z    -> 0.0001s
2025-09-29T21:13:45.259501647Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-09-29T21:13:45.259509763Z 
2025-09-29T21:13:45.259517529Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-09-29T21:13:45.259525585Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-09-29T21:13:45.259533701Z -- table_exists?(:active_storage_blobs)
2025-09-29T21:13:45.259541667Z    -> 0.0001s
2025-09-29T21:13:45.259549593Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-09-29T21:13:45.259557720Z 
2025-09-29T21:13:45.259565485Z Migrating to DeviseCreateUsers (20220614210023)
2025-09-29T21:13:45.259573461Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-09-29T21:13:45.259581908Z -- create_table(:users)
2025-09-29T21:13:45.259589824Z    -> 0.0013s
2025-09-29T21:13:45.259597810Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-09-29T21:13:45.259606147Z    -> 0.0017s
2025-09-29T21:13:45.259614073Z == 20220614210023 DeviseCreateUsers: migrated (0.0031s) =======================
2025-09-29T21:13:45.259622099Z 
2025-09-29T21:13:45.259629855Z Migrating to AddUsernameToUsers (20220614211256)
2025-09-29T21:13:45.259647631Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-09-29T21:13:45.259657350Z -- add_column(:users, :username, :string, {null: false})
2025-09-29T21:13:45.259665477Z    -> 0.0249s
2025-09-29T21:13:45.259673493Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-09-29T21:13:45.259681760Z    -> 0.0002s
2025-09-29T21:13:45.259689706Z == 20220614211256 AddUsernameToUsers: migrated (0.0251s) ======================
2025-09-29T21:13:45.259697792Z 
2025-09-29T21:13:45.259705527Z Migrating to AddAdminToUsers (20220614213902)
2025-09-29T21:13:45.259713453Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-09-29T21:13:45.259721480Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-29T21:13:45.259729576Z    -> 0.0005s
2025-09-29T21:13:45.259737542Z == 20220614213902 AddAdminToUsers: migrated (0.0006s) =========================
2025-09-29T21:13:45.259745638Z 
2025-09-29T21:13:45.259753414Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-09-29T21:13:45.259761410Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-09-29T21:13:45.259769566Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-09-29T21:13:45.259778765Z    -> 0.0012s
2025-09-29T21:13:45.259786731Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0013s) =============
2025-09-29T21:13:45.259794807Z 
2025-09-29T21:13:45.259802603Z Migrating to CreateSettings (20220619174307)
2025-09-29T21:13:45.259810509Z == 20220619174307 CreateSettings: migrating ===================================
2025-09-29T21:13:45.259818896Z -- create_table(:settings)
2025-09-29T21:13:45.259826832Z    -> 0.0028s
2025-09-29T21:13:45.259834738Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-09-29T21:13:45.259842974Z    -> 0.0002s
2025-09-29T21:13:45.259872774Z == 20220619174307 CreateSettings: migrated (0.0031s) ==========================
2025-09-29T21:13:45.259881231Z 
2025-09-29T21:13:45.259889007Z Migrating to AddScaleFactorToModels (20220626152444)
2025-09-29T21:13:45.259897193Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-09-29T21:13:45.259905209Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-09-29T21:13:45.259913296Z    -> 0.0105s
2025-09-29T21:13:45.259921262Z == 20220626152444 AddScaleFactorToModels: migrated (0.0129s) ==================
2025-09-29T21:13:45.259929348Z 
2025-09-29T21:13:45.259937104Z Migrating to AddDigestToModelFiles (20220702202932)
2025-09-29T21:13:45.259955270Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-09-29T21:13:45.259963487Z -- add_column(:model_files, :digest, :string)
2025-09-29T21:13:45.259971473Z    -> 0.0025s
2025-09-29T21:13:45.259979379Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-09-29T21:13:45.259987585Z    -> 0.0002s
2025-09-29T21:13:45.259995551Z == 20220702202932 AddDigestToModelFiles: migrated (0.0047s) ===================
2025-09-29T21:13:45.260003608Z 
2025-09-29T21:13:45.260011383Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-09-29T21:13:45.260019439Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-09-29T21:13:45.260028207Z -- add_column(:users, :renderer_settings, :json, {default: {"grid_width" => 200, "grid_depth" => 200, "show_grid" => true, "enable_pan_zoom" => false, "background_colour" => "#000000", "object_colour" => "#ffffff", "render_style" => "original"}})
2025-09-29T21:13:45.260039941Z    -> 0.0008s
2025-09-29T21:13:45.260048107Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0012s) ==============
2025-09-29T21:13:45.260056254Z 
2025-09-29T21:13:45.260064059Z Migrating to CreateProblems (20221210001132)
2025-09-29T21:13:45.260072095Z == 20221210001132 CreateProblems: migrating ===================================
2025-09-29T21:13:45.260080152Z -- create_table(:problems)
2025-09-29T21:13:45.260088018Z    -> 0.0009s
2025-09-29T21:13:45.260095994Z == 20221210001132 CreateProblems: migrated (0.0013s) ==========================
2025-09-29T21:13:45.260104040Z 
2025-09-29T21:13:45.260111805Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-09-29T21:13:45.260119802Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-09-29T21:13:45.260127828Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0175s) ========
2025-09-29T21:13:45.260135894Z 
2025-09-29T21:13:45.260143609Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-09-29T21:13:45.260151596Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-09-29T21:13:45.260159722Z -- create_table(:favorites, {force: true})
2025-09-29T21:13:45.260167778Z    -> 0.0043s
2025-09-29T21:13:45.260175704Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-09-29T21:13:45.260184311Z    -> 0.0001s
2025-09-29T21:13:45.260192207Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-09-29T21:13:45.260200735Z    -> 0.0001s
2025-09-29T21:13:45.260208731Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-09-29T21:13:45.260226907Z    -> 0.0001s
2025-09-29T21:13:45.260234913Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0052s) ================
2025-09-29T21:13:45.260243000Z 
2025-09-29T21:13:45.260250815Z Migrating to MovePrintedToFavorites (20221220223040)
2025-09-29T21:13:45.260258892Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-09-29T21:13:45.260267028Z == 20221220223040 MovePrintedToFavorites: migrated (0.0588s) ==================
2025-09-29T21:13:45.260275104Z 
2025-09-29T21:13:45.260282850Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-09-29T21:13:45.260290886Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-09-29T21:13:45.260299062Z -- remove_column(:model_files, :printed, :boolean)
2025-09-29T21:13:45.260307069Z    -> 0.0265s
2025-09-29T21:13:45.260314965Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0269s) ===============
2025-09-29T21:13:45.260323041Z 
2025-09-29T21:13:45.260330776Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-09-29T21:13:45.260339524Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-09-29T21:13:45.260347730Z -- add_column(:models, :notes, :text)
2025-09-29T21:13:45.260355747Z    -> 0.0014s
2025-09-29T21:13:45.260363743Z -- add_column(:models, :excerpt, :text)
2025-09-29T21:13:45.260371739Z    -> 0.0023s
2025-09-29T21:13:45.260379685Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0037s) =================
2025-09-29T21:13:45.260387811Z 
2025-09-29T21:13:45.260395627Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-09-29T21:13:45.260403633Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-09-29T21:13:45.260411719Z -- add_column(:creators, :notes, :text)
2025-09-29T21:13:45.260419685Z    -> 0.0005s
2025-09-29T21:13:45.260429525Z -- add_column(:creators, :excerpt, :text)
2025-09-29T21:13:45.260437501Z    -> 0.0005s
2025-09-29T21:13:45.260445427Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-09-29T21:13:45.260453644Z 
2025-09-29T21:13:45.260461419Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-09-29T21:13:45.260469426Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-09-29T21:13:45.260477522Z -- add_column(:model_files, :notes, :text)
2025-09-29T21:13:45.260485508Z    -> 0.0005s
2025-09-29T21:13:45.260493494Z -- add_column(:model_files, :excerpt, :text)
2025-09-29T21:13:45.260501500Z    -> 0.0005s
2025-09-29T21:13:45.260518504Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0010s) =============
2025-09-29T21:13:45.260526731Z 
2025-09-29T21:13:45.260534527Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-09-29T21:13:45.260542743Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-09-29T21:13:45.260550849Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0208s) =================
2025-09-29T21:13:45.260558956Z 
2025-09-29T21:13:45.260566822Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-09-29T21:13:45.260574848Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-09-29T21:13:45.260582904Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-09-29T21:13:45.260591231Z    -> 0.0442s
2025-09-29T21:13:45.260599117Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0443s) =============
2025-09-29T21:13:45.260607213Z 
2025-09-29T21:13:45.260614969Z Migrating to RenameExcerptToCaption (20230222155910)
2025-09-29T21:13:45.260622985Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-09-29T21:13:45.260631151Z -- rename_column(:creators, :excerpt, :caption)
2025-09-29T21:13:45.260639157Z    -> 0.0238s
2025-09-29T21:13:45.260647083Z -- rename_column(:models, :excerpt, :caption)
2025-09-29T21:13:45.260655099Z    -> 0.0212s
2025-09-29T21:13:45.260663035Z -- rename_column(:model_files, :excerpt, :caption)
2025-09-29T21:13:45.260671031Z    -> 0.0197s
2025-09-29T21:13:45.260678967Z == 20230222155910 RenameExcerptToCaption: migrated (0.0677s) ==================
2025-09-29T21:13:45.260687104Z 
2025-09-29T21:13:45.260694900Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-09-29T21:13:45.260702946Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-09-29T21:13:45.260711022Z -- add_column(:libraries, :notes, :string)
2025-09-29T21:13:45.260719158Z    -> 0.0027s
2025-09-29T21:13:45.260727195Z -- add_column(:libraries, :caption, :string)
2025-09-29T21:13:45.739825543Z    -> 0.0005s
2025-09-29T21:13:45.739887538Z -- add_column(:libraries, :name, :string)
2025-09-29T21:13:45.739906466Z    -> 0.0005s
2025-09-29T21:13:45.739918240Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0130s) ============
2025-09-29T21:13:45.739928891Z 
2025-09-29T21:13:45.739940124Z Migrating to AddTagregexToLibrary (20230305180823)
2025-09-29T21:13:45.739950465Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-09-29T21:13:45.739963350Z -- add_column(:libraries, :tag_regex, :text)
2025-09-29T21:13:45.740003521Z    -> 0.0020s
2025-09-29T21:13:45.740013662Z == 20230305180823 AddTagregexToLibrary: migrated (0.0037s) ====================
2025-09-29T21:13:45.740024013Z 
2025-09-29T21:13:45.740034213Z Migrating to AddIconToLibrary (20230307215826)
2025-09-29T21:13:45.740044674Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-09-29T21:13:45.740055386Z -- add_column(:libraries, :icon, :text)
2025-09-29T21:13:45.740066258Z    -> 0.0020s
2025-09-29T21:13:45.740076689Z == 20230307215826 AddIconToLibrary: migrated (0.0037s) ========================
2025-09-29T21:13:45.740087210Z 
2025-09-29T21:13:45.740097711Z Migrating to CreateCollection (20230308004237)
2025-09-29T21:13:45.740108543Z == 20230308004237 CreateCollection: migrating =================================
2025-09-29T21:13:45.740119074Z -- create_table(:collections)
2025-09-29T21:13:45.740129625Z    -> 0.0028s
2025-09-29T21:13:45.740140056Z == 20230308004237 CreateCollection: migrated (0.0072s) ========================
2025-09-29T21:13:45.740150668Z 
2025-09-29T21:13:45.740159265Z Migrating to AddCollectionToModels (20230308005021)
2025-09-29T21:13:45.740167492Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-09-29T21:13:45.740175578Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-09-29T21:13:45.740183804Z    -> 0.0181s
2025-09-29T21:13:45.740191740Z == 20230308005021 AddCollectionToModels: migrated (0.0218s) ===================
2025-09-29T21:13:45.740199867Z 
2025-09-29T21:13:45.740207672Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-09-29T21:13:45.740216620Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-09-29T21:13:45.740224937Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0014s) =============
2025-09-29T21:13:45.740233033Z 
2025-09-29T21:13:45.740241410Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-09-29T21:13:45.740250018Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-09-29T21:13:45.740258124Z -- rename_column(:collections, :excerpt, :caption)
2025-09-29T21:13:45.740266371Z    -> 0.0043s
2025-09-29T21:13:45.740274287Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0043s) ========
2025-09-29T21:13:45.740282483Z 
2025-09-29T21:13:45.740290309Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-09-29T21:13:45.740298405Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-09-29T21:13:45.740306481Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-09-29T21:13:45.740314598Z 
2025-09-29T21:13:45.740334067Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-09-29T21:13:45.740344087Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-09-29T21:13:45.740352444Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-09-29T21:13:45.740362133Z    -> 0.0015s
2025-09-29T21:13:45.740370430Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0016s) ===============
2025-09-29T21:13:45.740378687Z 
2025-09-29T21:13:45.740386543Z Migrating to AddCollectionToCollections (20230324000000)
2025-09-29T21:13:45.740394649Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-09-29T21:13:45.740403026Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-09-29T21:13:45.740411192Z    -> 0.0060s
2025-09-29T21:13:45.740419158Z == 20230324000000 AddCollectionToCollections: migrated (0.0080s) ==============
2025-09-29T21:13:45.740427275Z 
2025-09-29T21:13:45.740435150Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-09-29T21:13:45.740443237Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-09-29T21:13:45.740451323Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0486s) =========
2025-09-29T21:13:45.740460321Z 
2025-09-29T21:13:45.740469920Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-09-29T21:13:45.740479891Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-09-29T21:13:45.740490151Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0065s) 
2025-09-29T21:13:45.740500452Z 
2025-09-29T21:13:45.740510041Z Migrating to AddSlugs (20230615135601)
2025-09-29T21:13:45.740520001Z == 20230615135601 AddSlugs: migrating =========================================
2025-09-29T21:13:45.740530422Z -- add_column(:models, :slug, :string)
2025-09-29T21:13:45.740541394Z    -> 0.0028s
2025-09-29T21:13:45.740551845Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-09-29T21:13:45.740564471Z    -> 0.0022s
2025-09-29T21:13:45.740573409Z -- add_column(:collections, :slug, :string)
2025-09-29T21:13:45.740583399Z    -> 0.0005s
2025-09-29T21:13:45.740594090Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-09-29T21:13:45.740604652Z    -> 0.0001s
2025-09-29T21:13:45.740615213Z -- add_column(:creators, :slug, :string)
2025-09-29T21:13:45.740625864Z    -> 0.0005s
2025-09-29T21:13:45.740636295Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-09-29T21:13:45.740646706Z    -> 0.0001s
2025-09-29T21:13:45.740694623Z == 20230615135601 AddSlugs: migrated (0.0068s) ================================
2025-09-29T21:13:45.740706988Z 
2025-09-29T21:13:45.740717268Z Migrating to GenerateSlugs (20230617222353)
2025-09-29T21:13:45.740727329Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-09-29T21:13:45.740737589Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-09-29T21:13:45.740748501Z 
2025-09-29T21:13:45.740759203Z Migrating to MakeNamesUnique (20230628194944)
2025-09-29T21:13:45.740769955Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-09-29T21:13:45.740782219Z == 20230628194944 MakeNamesUnique: migrated (0.0034s) =========================
2025-09-29T21:13:45.740793141Z 
2025-09-29T21:13:45.740802831Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-09-29T21:13:45.740813562Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-09-29T21:13:45.740823803Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-09-29T21:13:45.740833412Z    -> 0.0022s
2025-09-29T21:13:45.740842671Z -- remove_index(:creators, :slug)
2025-09-29T21:13:45.740852080Z    -> 0.0005s
2025-09-29T21:13:45.740861008Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-09-29T21:13:45.740871158Z    -> 0.0002s
2025-09-29T21:13:45.740881419Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-09-29T21:13:45.740892581Z    -> 0.0002s
2025-09-29T21:13:45.740902952Z -- remove_index(:collections, :slug)
2025-09-29T21:13:45.740913263Z    -> 0.0237s
2025-09-29T21:13:45.740923594Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-09-29T21:13:45.740934756Z    -> 0.0006s
2025-09-29T21:13:45.740945177Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0278s) ======
2025-09-29T21:13:45.740955819Z 
2025-09-29T21:13:45.740965629Z Migrating to AddSizeToModelFiles (20230707082403)
2025-09-29T21:13:45.740975599Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-09-29T21:13:45.740985929Z -- add_column(:model_files, :size, :integer)
2025-09-29T21:13:45.740996170Z    -> 0.0006s
2025-09-29T21:13:45.741004357Z == 20230707082403 AddSizeToModelFiles: migrated (0.0009s) =====================
2025-09-29T21:13:45.741013856Z 
2025-09-29T21:13:45.741024056Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-09-29T21:13:45.741034147Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-09-29T21:13:45.741044688Z -- change_column(:model_files, :size, :bigint)
2025-09-29T21:13:45.741070470Z    -> 0.0089s
2025-09-29T21:13:45.741080540Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0093s) ==================
2025-09-29T21:13:45.741088867Z 
2025-09-29T21:13:45.741096692Z Migrating to AddNoteToProblems (20230711111009)
2025-09-29T21:13:45.741104679Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-09-29T21:13:45.741112825Z -- add_column(:problems, :note, :string, {default: nil})
2025-09-29T21:13:45.741120841Z    -> 0.0012s
2025-09-29T21:13:45.741128787Z == 20230711111009 AddNoteToProblems: migrated (0.0023s) =======================
2025-09-29T21:13:45.741136883Z 
2025-09-29T21:13:45.741145030Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-09-29T21:13:45.741155401Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-09-29T21:13:45.741168026Z -- add_column(:users, :problem_settings, :json, {default: {"missing" => :danger, "empty" => :info, "nesting" => :warning, "inefficient" => :info, "duplicate" => :warning, "no_image" => :silent, "no_3d_model" => :silent, "non_manifold" => :warning, "inside_out" => :warning, "no_license" => :silent, "no_links" => :silent, "no_creator" => :silent, "no_tags" => :silent, "http_error" => :info, "file_naming" => :warning}})
2025-09-29T21:13:45.741186614Z    -> 0.0006s
2025-09-29T21:13:45.741196864Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-09-29T21:13:45.741206233Z 
2025-09-29T21:13:45.741214129Z Migrating to AddLicenseToModel (20240127143358)
2025-09-29T21:13:45.741222095Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-09-29T21:13:45.741230171Z -- add_column(:models, :license, :string)
2025-09-29T21:13:45.741238288Z    -> 0.0006s
2025-09-29T21:13:45.741247025Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-09-29T21:13:45.741257236Z 
2025-09-29T21:13:45.741266875Z Migrating to AddIgnoredToProblems (20240131134832)
2025-09-29T21:13:45.741276545Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-09-29T21:13:45.741284821Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-09-29T21:13:45.741292877Z    -> 0.0006s
2025-09-29T21:13:45.741300783Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-09-29T21:13:45.741309401Z 
2025-09-29T21:13:45.741317146Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-09-29T21:13:45.741325183Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-09-29T21:13:45.741333239Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-09-29T21:13:45.741352387Z    -> 0.0105s
2025-09-29T21:13:45.741360454Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0106s) ======
2025-09-29T21:13:45.741368550Z 
2025-09-29T21:13:45.741376616Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-09-29T21:13:45.741386746Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-09-29T21:13:45.741395604Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-09-29T21:13:45.741404632Z    -> 0.0006s
2025-09-29T21:13:45.741414472Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-09-29T21:13:45.741424653Z 
2025-09-29T21:13:45.741434893Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-09-29T21:13:45.741445385Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-09-29T21:13:45.741456006Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-09-29T21:13:45.741467289Z    -> 0.0002s
2025-09-29T21:13:45.741477319Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-09-29T21:13:45.741487199Z    -> 0.0010s
2025-09-29T21:13:45.741495175Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-09-29T21:13:45.741503572Z    -> 0.0001s
2025-09-29T21:13:45.741513913Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-09-29T21:13:45.741525366Z    -> 0.0045s
2025-09-29T21:13:46.337402837Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0059s) =================
2025-09-29T21:13:46.337448389Z 
2025-09-29T21:13:46.337458079Z Migrating to CreateFlipperTables (20240306095646)
2025-09-29T21:13:46.337466636Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-09-29T21:13:46.337475253Z -- create_table(:flipper_features)
2025-09-29T21:13:46.337483450Z    -> 0.0027s
2025-09-29T21:13:46.337492318Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-09-29T21:13:46.337501446Z    -> 0.0048s
2025-09-29T21:13:46.337511336Z -- create_table(:flipper_gates)
2025-09-29T21:13:46.337522067Z    -> 0.0003s
2025-09-29T21:13:46.337532458Z -- add_index(:flipper_gates, [:feature_key, :key, :value], {unique: true, length: {value: 255}, name: "index_flipper_gates_on_feature_key_and_key_and_value"})
2025-09-29T21:13:46.337541547Z    -> 0.0001s
2025-09-29T21:13:46.337549683Z == 20240306095646 CreateFlipperTables: migrated (0.0080s) =====================
2025-09-29T21:13:46.337577689Z 
2025-09-29T21:13:46.337588531Z Migrating to RolifyCreateRoles (20240319155251)
2025-09-29T21:13:46.337599002Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-09-29T21:13:46.337607690Z -- create_table(:roles)
2025-09-29T21:13:46.337616207Z    -> 0.0381s
2025-09-29T21:13:46.337624754Z -- create_table(:users_roles, {id: false})
2025-09-29T21:13:46.337633181Z    -> 0.0005s
2025-09-29T21:13:46.337641318Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-09-29T21:13:46.337649684Z    -> 0.0051s
2025-09-29T21:13:46.337657941Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-09-29T21:13:46.337668853Z    -> 0.0002s
2025-09-29T21:13:46.337679294Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-09-29T21:13:46.337689815Z    -> 0.0001s
2025-09-29T21:13:46.337698082Z == 20240319155251 RolifyCreateRoles: migrated (0.0611s) =======================
2025-09-29T21:13:46.337706419Z 
2025-09-29T21:13:46.337714625Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-09-29T21:13:46.337723243Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-09-29T21:13:46.337731539Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0070s) ==================
2025-09-29T21:13:46.337739856Z 
2025-09-29T21:13:46.337748363Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-09-29T21:13:46.337756580Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-09-29T21:13:46.337764896Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-29T21:13:46.337773323Z    -> 0.0244s
2025-09-29T21:13:46.337781660Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0257s) ====================
2025-09-29T21:13:46.337790047Z 
2025-09-29T21:13:46.337797993Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-09-29T21:13:46.337806250Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-09-29T21:13:46.337814607Z -- add_column(:users, :reset_password_token, :string)
2025-09-29T21:13:46.337823013Z    -> 0.0011s
2025-09-29T21:13:46.337831140Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-09-29T21:13:46.337841711Z    -> 0.0002s
2025-09-29T21:13:46.337852363Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0033s) ============
2025-09-29T21:13:46.337862824Z 
2025-09-29T21:13:46.337871982Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-09-29T21:13:46.337880589Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-09-29T21:13:46.337899648Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0242s) ==============
2025-09-29T21:13:46.337908235Z 
2025-09-29T21:13:46.337918135Z Migrating to AddRememberableToUsers (20240410221112)
2025-09-29T21:13:46.337928546Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-09-29T21:13:46.337938316Z -- add_column(:users, :remember_created_at, :datetime)
2025-09-29T21:13:46.337946823Z    -> 0.0030s
2025-09-29T21:13:46.337955340Z == 20240410221112 AddRememberableToUsers: migrated (0.0042s) ==================
2025-09-29T21:13:46.337964068Z 
2025-09-29T21:13:46.337972725Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-09-29T21:13:46.337981102Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-09-29T21:13:46.337992455Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-09-29T21:13:46.338003226Z    -> 0.0006s
2025-09-29T21:13:46.338013567Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0019s) ===========
2025-09-29T21:13:46.338022034Z 
2025-09-29T21:13:46.338030391Z Migrating to DropDelayedJobs (20240418112821)
2025-09-29T21:13:46.338038568Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-09-29T21:13:46.338046964Z -- drop_table(:delayed_jobs)
2025-09-29T21:13:46.338055131Z    -> 0.0019s
2025-09-29T21:13:46.338064610Z == 20240418112821 DropDelayedJobs: migrated (0.0118s) =========================
2025-09-29T21:13:46.338075141Z 
2025-09-29T21:13:46.338085302Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-09-29T21:13:46.338095923Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-09-29T21:13:46.338106424Z -- add_column(:users, :interface_language, :string)
2025-09-29T21:13:46.338116755Z    -> 0.0007s
2025-09-29T21:13:46.338125863Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0042s) =============
2025-09-29T21:13:46.338134431Z 
2025-09-29T21:13:46.338143058Z Migrating to AddLockableToUsers (20240610120318)
2025-09-29T21:13:46.338151405Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-09-29T21:13:46.338160122Z -- change_table(:users)
2025-09-29T21:13:46.338168469Z    -> 0.0018s
2025-09-29T21:13:46.338176886Z == 20240610120318 AddLockableToUsers: migrated (0.0022s) ======================
2025-09-29T21:13:46.338185594Z 
2025-09-29T21:13:46.338193900Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-09-29T21:13:46.338202347Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-09-29T21:13:46.338211295Z -- add_column(:model_files, :attachment_data, :json)
2025-09-29T21:13:46.338231957Z    -> 0.0006s
2025-09-29T21:13:46.338244011Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0009s) ===========
2025-09-29T21:13:46.338254963Z 
2025-09-29T21:13:46.338264823Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-09-29T21:13:46.338276437Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-09-29T21:13:46.338287519Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0220s) ==================
2025-09-29T21:13:46.338298761Z 
2025-09-29T21:13:46.338308952Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-09-29T21:13:46.338319934Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-09-29T21:13:46.338331127Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-09-29T21:13:46.338342309Z    -> 0.0008s
2025-09-29T21:13:46.338352550Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0027s) ============
2025-09-29T21:13:46.338362921Z 
2025-09-29T21:13:46.338372921Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-09-29T21:13:46.338383723Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-09-29T21:13:46.338392410Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-09-29T21:13:46.338402210Z    -> 0.0008s
2025-09-29T21:13:46.338412811Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-09-29T21:13:46.338423072Z    -> 0.0006s
2025-09-29T21:13:46.338432771Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-09-29T21:13:46.338441178Z    -> 0.0006s
2025-09-29T21:13:46.338449896Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-09-29T21:13:46.338458203Z    -> 0.0052s
2025-09-29T21:13:46.338467050Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-09-29T21:13:46.338475437Z    -> 0.0006s
2025-09-29T21:13:46.338483554Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0090s) ====================
2025-09-29T21:13:46.338491910Z 
2025-09-29T21:13:46.338499917Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-09-29T21:13:46.338508163Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-09-29T21:13:46.338516520Z -- remove_index(:libraries, :path)
2025-09-29T21:13:46.338524817Z    -> 0.0011s
2025-09-29T21:13:46.338533003Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0019s) ================
2025-09-29T21:13:46.338541330Z 
2025-09-29T21:13:46.338549336Z Migrating to CreateFederailsActors (20240727113215)
2025-09-29T21:13:46.338557793Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-09-29T21:13:46.338577653Z -- create_table(:federails_actors)
2025-09-29T21:13:46.338587493Z    -> 0.0013s
2025-09-29T21:13:46.338595760Z -- foreign_key_exists?(:federails_actors, :users)
2025-09-29T21:13:46.338604146Z    -> 0.0021s
2025-09-29T21:13:46.338612313Z -- remove_foreign_key(:federails_actors, :users)
2025-09-29T21:13:46.338620690Z    -> 0.0234s
2025-09-29T21:13:46.338629297Z -- remove_index(:federails_actors, :user_id)
2025-09-29T21:13:46.338637944Z    -> 0.0004s
2025-09-29T21:13:46.338646472Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-09-29T21:13:46.338655420Z    -> 0.0001s
2025-09-29T21:13:46.338663807Z -- add_foreign_key(:federails_actors, :users)
2025-09-29T21:13:46.338672163Z    -> 0.0171s
2025-09-29T21:13:46.338681182Z == 20240727113215 CreateFederailsActors: migrated (0.0453s) ===================
2025-09-29T21:13:46.338689699Z 
2025-09-29T21:13:46.338697945Z Migrating to CreateFederailsFollowings (20240727113216)
2025-09-29T21:13:46.338707364Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-09-29T21:13:46.338716222Z -- create_table(:federails_followings)
2025-09-29T21:13:46.338724769Z    -> 0.0020s
2025-09-29T21:13:46.338733186Z == 20240727113216 CreateFederailsFollowings: migrated (0.0020s) ===============
2025-09-29T21:13:46.338741613Z 
2025-09-29T21:13:46.338749569Z Migrating to CreateFederailsActivities (20240727113217)
2025-09-29T21:13:46.338757936Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-09-29T21:13:46.338766403Z -- create_table(:federails_activities)
2025-09-29T21:13:46.338776293Z    -> 0.0092s
2025-09-29T21:13:46.338786624Z == 20240727113217 CreateFederailsActivities: migrated (0.0092s) ===============
2025-09-29T21:13:46.338797265Z 
2025-09-29T21:13:46.338807306Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-09-29T21:13:46.338817486Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-09-29T21:13:46.338827246Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-09-29T21:13:46.338835733Z    -> 0.0191s
2025-09-29T21:13:46.338844060Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-09-29T21:13:46.338852637Z    -> 0.0004s
2025-09-29T21:13:46.338860773Z -- change_table(:federails_actors)
2025-09-29T21:13:46.338869130Z    -> 0.0113s
2025-09-29T21:13:46.338877537Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0309s) =======
2025-09-29T21:13:46.338897307Z 
2025-09-29T21:13:46.338907287Z Migrating to CreateFederailsActors (20240731165647)
2025-09-29T21:13:46.338917287Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-09-29T21:13:46.338925694Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-09-29T21:13:46.338933951Z 
2025-09-29T21:13:46.338941907Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-09-29T21:13:46.338950063Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-09-29T21:13:46.338958380Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-09-29T21:13:46.338969071Z 
2025-09-29T21:13:46.338979041Z Migrating to BackfillActivities (20240805111500)
2025-09-29T21:13:46.338988420Z == 20240805111500 BackfillActivities: migrating ===============================
2025-09-29T21:13:46.338997258Z == 20240805111500 BackfillActivities: migrated (0.0006s) ======================
2025-09-29T21:13:46.339005845Z 
2025-09-29T21:13:46.339014713Z Migrating to CreateCaberRelations (20240827155630)
2025-09-29T21:13:46.339025304Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-09-29T21:13:46.339036046Z -- create_table(:caber_relations)
2025-09-29T21:13:46.339046257Z    -> 0.0414s
2025-09-29T21:13:46.339056688Z == 20240827155630 CreateCaberRelations: migrated (0.0414s) ====================
2025-09-29T21:13:46.339067099Z 
2025-09-29T21:13:46.339075566Z Migrating to AddDefaultAccessControls (20240830121749)
2025-09-29T21:13:46.339083782Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-09-29T21:13:46.339092079Z == 20240830121749 AddDefaultAccessControls: migrated (0.0614s) ================
2025-09-29T21:13:46.339100366Z 
2025-09-29T21:13:46.339109254Z Migrating to RenameDefaultRoles (20240830151650)
2025-09-29T21:13:46.993503061Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-09-29T21:13:46.993546028Z == 20240830151650 RenameDefaultRoles: migrated (0.0414s) ======================
2025-09-29T21:13:46.993555317Z 
2025-09-29T21:13:46.993563333Z Migrating to AddPublicIDsToModels (20240904151944)
2025-09-29T21:13:46.993571619Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-09-29T21:13:46.993579876Z -- add_column(:models, :public_id, :string)
2025-09-29T21:13:46.993588343Z    -> 0.0009s
2025-09-29T21:13:46.993597331Z -- add_index(:models, :public_id)
2025-09-29T21:13:46.993605598Z    -> 0.0031s
2025-09-29T21:13:46.993614095Z -- add_column(:model_files, :public_id, :string)
2025-09-29T21:13:46.993622692Z    -> 0.0007s
2025-09-29T21:13:46.993661230Z -- add_index(:model_files, :public_id)
2025-09-29T21:13:46.993669537Z    -> 0.0001s
2025-09-29T21:13:46.993677913Z -- add_column(:problems, :public_id, :string)
2025-09-29T21:13:46.993686601Z    -> 0.0007s
2025-09-29T21:13:46.993694557Z -- add_index(:problems, :public_id)
2025-09-29T21:13:46.993702523Z    -> 0.0001s
2025-09-29T21:13:46.993710519Z -- add_column(:creators, :public_id, :string)
2025-09-29T21:13:46.993718505Z    -> 0.0006s
2025-09-29T21:13:46.993726421Z -- add_index(:creators, :public_id)
2025-09-29T21:13:46.993734357Z    -> 0.0001s
2025-09-29T21:13:46.993742253Z -- add_column(:collections, :public_id, :string)
2025-09-29T21:13:46.993750550Z    -> 0.0006s
2025-09-29T21:13:46.993758576Z -- add_index(:collections, :public_id)
2025-09-29T21:13:46.993766512Z    -> 0.0001s
2025-09-29T21:13:46.993774929Z -- add_column(:libraries, :public_id, :string)
2025-09-29T21:13:46.993783306Z    -> 0.0006s
2025-09-29T21:13:46.993791312Z -- add_index(:libraries, :public_id)
2025-09-29T21:13:46.993799568Z    -> 0.0001s
2025-09-29T21:13:46.993807825Z == 20240904151944 AddPublicIDsToModels: migrated (0.0082s) ====================
2025-09-29T21:13:46.993816312Z 
2025-09-29T21:13:46.993824358Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-09-29T21:13:46.993835731Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-09-29T21:13:46.993844569Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:46.993852976Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0508s) ==============
2025-09-29T21:13:46.993861152Z 
2025-09-29T21:13:46.993869479Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-09-29T21:13:46.993877706Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-09-29T21:13:46.993885832Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-09-29T21:13:46.993893949Z 
2025-09-29T21:13:46.993901905Z Migrating to DeduplicateRoles (20240923114515)
2025-09-29T21:13:46.993910492Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-09-29T21:13:46.993918578Z == 20240923114515 DeduplicateRoles: migrated (0.1549s) ========================
2025-09-29T21:13:46.993927105Z 
2025-09-29T21:13:46.993934831Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-09-29T21:13:46.993942857Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-09-29T21:13:46.993951304Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-29T21:13:46.994164644Z    -> 0.0418s
2025-09-29T21:13:46.994176257Z -- add_index(:models, :name_lower)
2025-09-29T21:13:46.994184363Z    -> 0.0002s
2025-09-29T21:13:46.994192450Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-29T21:13:46.994200897Z    -> 0.1273s
2025-09-29T21:13:46.994208833Z -- add_index(:creators, :name_lower)
2025-09-29T21:13:46.994216809Z    -> 0.0002s
2025-09-29T21:13:46.994225025Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-29T21:13:46.994233983Z    -> 0.0096s
2025-09-29T21:13:46.994242571Z -- add_index(:collections, :name_lower)
2025-09-29T21:13:46.994250797Z    -> 0.0001s
2025-09-29T21:13:46.994258933Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1794s) =============
2025-09-29T21:13:46.994267250Z 
2025-09-29T21:13:46.994275266Z Migrating to AddKeypairToActors (20240926162407)
2025-09-29T21:13:46.994283643Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-09-29T21:13:46.994292241Z -- change_table(:federails_actors)
2025-09-29T21:13:46.994300427Z    -> 0.0015s
2025-09-29T21:13:46.994308543Z == 20240926162407 AddKeypairToActors: migrated (0.0015s) ======================
2025-09-29T21:13:46.994316980Z 
2025-09-29T21:13:46.994325017Z Migrating to AddUuids (20241004194445)
2025-09-29T21:13:46.994333023Z == 20241004194445 AddUuids: migrating =========================================
2025-09-29T21:13:46.994341129Z -- change_table(:federails_actors)
2025-09-29T21:13:46.994349035Z    -> 0.0030s
2025-09-29T21:13:46.994357001Z -- change_table(:federails_activities)
2025-09-29T21:13:46.994365007Z    -> 0.0008s
2025-09-29T21:13:46.994372923Z -- change_table(:federails_followings)
2025-09-29T21:13:46.994380849Z    -> 0.0008s
2025-09-29T21:13:46.994389005Z == 20241004194445 AddUuids: migrated (0.0047s) ================================
2025-09-29T21:13:46.994397072Z 
2025-09-29T21:13:46.994405038Z Migrating to CreateComments (20241007182824)
2025-09-29T21:13:46.994413304Z == 20241007182824 CreateComments: migrating ===================================
2025-09-29T21:13:46.994421801Z -- create_table(:comments)
2025-09-29T21:13:46.994430048Z    -> 0.0020s
2025-09-29T21:13:46.994438455Z == 20241007182824 CreateComments: migrated (0.0020s) ==========================
2025-09-29T21:13:46.994446832Z 
2025-09-29T21:13:46.994454868Z Migrating to AddSystemToComments (20241009122540)
2025-09-29T21:13:46.994463075Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-09-29T21:13:46.994482163Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-09-29T21:13:46.994491181Z    -> 0.0008s
2025-09-29T21:13:46.994499478Z == 20241009122540 AddSystemToComments: migrated (0.0009s) =====================
2025-09-29T21:13:46.994508005Z 
2025-09-29T21:13:46.994515771Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-09-29T21:13:46.994524318Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-09-29T21:13:46.994532344Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0017s) ============
2025-09-29T21:13:46.994540400Z 
2025-09-29T21:13:46.994548206Z Migrating to AddOmniauthToUsers (20241015090803)
2025-09-29T21:13:46.994556192Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-09-29T21:13:46.994564379Z -- add_column(:users, :auth_provider, :string)
2025-09-29T21:13:46.994572435Z    -> 0.0008s
2025-09-29T21:13:46.994580371Z -- add_column(:users, :auth_uid, :string)
2025-09-29T21:13:46.994589148Z    -> 0.0007s
2025-09-29T21:13:46.994597345Z == 20241015090803 AddOmniauthToUsers: migrated (0.0016s) ======================
2025-09-29T21:13:46.994605451Z 
2025-09-29T21:13:46.994613447Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-09-29T21:13:46.994621453Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-09-29T21:13:46.994629941Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-09-29T21:13:46.994637987Z    -> 0.0008s
2025-09-29T21:13:46.994645903Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-09-29T21:13:46.994654019Z    -> 0.0007s
2025-09-29T21:13:46.994661905Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0015s) =====
2025-09-29T21:13:46.994669971Z 
2025-09-29T21:13:46.994677717Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-09-29T21:13:46.994685763Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-09-29T21:13:46.994693859Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-09-29T21:13:46.994701905Z    -> 0.0008s
2025-09-29T21:13:46.994709801Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-09-29T21:13:46.994717858Z 
2025-09-29T21:13:46.994725593Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-09-29T21:13:46.994733599Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-09-29T21:13:46.994741876Z -- change_table(:users)
2025-09-29T21:13:46.994750052Z    -> 0.0009s
2025-09-29T21:13:46.994758249Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-09-29T21:13:46.994775584Z 
2025-09-29T21:13:46.994783450Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-09-29T21:13:46.994791736Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-09-29T21:13:46.994799783Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0040s) =================
2025-09-29T21:13:46.994807999Z 
2025-09-29T21:13:46.994815855Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-09-29T21:13:46.994824302Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-09-29T21:13:46.994832889Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-09-29T21:13:46.994841416Z    -> 0.0008s
2025-09-29T21:13:46.994849392Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-09-29T21:13:46.994858090Z    -> 0.0012s
2025-09-29T21:13:46.994865986Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-09-29T21:13:46.994874212Z    -> 0.0004s
2025-09-29T21:13:46.994882609Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-09-29T21:13:46.994891648Z    -> 0.0009s
2025-09-29T21:13:46.994900175Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-09-29T21:13:46.994908872Z    -> 0.0008s
2025-09-29T21:13:46.994916918Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-09-29T21:13:46.994925345Z    -> 0.0010s
2025-09-29T21:13:46.994933913Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-09-29T21:13:46.994942480Z    -> 0.0004s
2025-09-29T21:13:46.994950626Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0058s) ===================
2025-09-29T21:13:46.994958913Z 
2025-09-29T21:13:46.994966919Z Migrating to AddInProgressToProblems (20241105121830)
2025-09-29T21:13:46.994975466Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-09-29T21:13:46.994983713Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-09-29T21:13:46.994991939Z    -> 0.0008s
2025-09-29T21:13:46.995000016Z == 20241105121830 AddInProgressToProblems: migrated (0.0008s) =================
2025-09-29T21:13:46.995008573Z 
2025-09-29T21:13:46.995016319Z Migrating to ClearStuckProblems (20241118155027)
2025-09-29T21:13:46.995024355Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-09-29T21:13:46.995033092Z == 20241118155027 ClearStuckProblems: migrated (0.0184s) ======================
2025-09-29T21:13:46.995050878Z 
2025-09-29T21:13:46.995059115Z Migrating to AddApprovedToUser (20241122121621)
2025-09-29T21:13:46.995067351Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-09-29T21:13:46.995075448Z -- change_table(:users)
2025-09-29T21:13:46.995083674Z    -> 0.0014s
2025-09-29T21:13:46.995093163Z == 20241122121621 AddApprovedToUser: migrated (0.0014s) =======================
2025-09-29T21:13:46.995101771Z 
2025-09-29T21:13:46.995110168Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-09-29T21:13:46.995118214Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-09-29T21:13:46.995126310Z -- create_table(:federails_moderation_reports)
2025-09-29T21:13:46.995134637Z    -> 0.0035s
2025-09-29T21:13:46.995142713Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0036s) ========
2025-09-29T21:13:46.995150809Z 
2025-09-29T21:13:46.995158876Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-09-29T21:13:46.995168174Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-09-29T21:13:46.995176561Z -- create_table(:federails_moderation_domain_blocks)
2025-09-29T21:13:46.995184607Z    -> 0.0005s
2025-09-29T21:13:46.995192503Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-09-29T21:13:46.995200640Z 
2025-09-29T21:13:46.995209067Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-09-29T21:13:46.995217484Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-09-29T21:13:46.995225570Z -- change_column_null(:comments, :commenter_id, true)
2025-09-29T21:13:46.995234257Z    -> 0.0080s
2025-09-29T21:13:46.995242484Z -- change_column_null(:comments, :commenter_type, true)
2025-09-29T21:13:46.995250550Z    -> 0.0079s
2025-09-29T21:13:46.995258496Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-09-29T21:13:46.995266593Z    -> 0.0009s
2025-09-29T21:13:46.995274669Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-09-29T21:13:46.995282775Z    -> 0.0108s
2025-09-29T21:13:47.776470402Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0290s) =======
2025-09-29T21:13:47.776521074Z 
2025-09-29T21:13:47.776530483Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-09-29T21:13:47.776538950Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-09-29T21:13:47.776547347Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-09-29T21:13:47.776555673Z    -> 0.0009s
2025-09-29T21:13:47.776593309Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0010s) =================
2025-09-29T21:13:47.776601756Z 
2025-09-29T21:13:47.776609792Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-09-29T21:13:47.776617989Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-09-29T21:13:47.776626326Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1225s) ==================
2025-09-29T21:13:47.776634492Z 
2025-09-29T21:13:47.776642448Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-09-29T21:13:47.776650705Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-09-29T21:13:47.776658761Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-09-29T21:13:47.776666887Z    -> 0.0021s
2025-09-29T21:13:47.776675114Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0021s) ==========
2025-09-29T21:13:47.776683250Z 
2025-09-29T21:13:47.776691116Z Migrating to AddCreatorToCollections (20250222000000)
2025-09-29T21:13:47.776699403Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-09-29T21:13:47.776707539Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-09-29T21:13:47.776715696Z    -> 0.0240s
2025-09-29T21:13:47.776723652Z == 20250222000000 AddCreatorToCollections: migrated (0.0241s) =================
2025-09-29T21:13:47.776732099Z 
2025-09-29T21:13:47.776739964Z Migrating to AddLocalToActors (20250305171530)
2025-09-29T21:13:47.776748271Z == 20250305171530 AddLocalToActors: migrating =================================
2025-09-29T21:13:47.776756378Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-09-29T21:13:47.776764514Z    -> 0.0012s
2025-09-29T21:13:47.776772470Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-09-29T21:13:47.776780957Z    -> 0.0019s
2025-09-29T21:13:47.776789003Z    -> 0 rows
2025-09-29T21:13:47.776796949Z == 20250305171530 AddLocalToActors: migrated (0.0063s) ========================
2025-09-29T21:13:47.776805066Z 
2025-09-29T21:13:47.776813292Z Migrating to AddActorTypeToActors (20250407160721)
2025-09-29T21:13:47.776821529Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-09-29T21:13:47.776829685Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-09-29T21:13:47.776842401Z    -> 0.0009s
2025-09-29T21:13:47.776852441Z == 20250407160721 AddActorTypeToActors: migrated (0.0009s) ====================
2025-09-29T21:13:47.776862651Z 
2025-09-29T21:13:47.776872321Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-09-29T21:13:47.776902512Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-09-29T21:13:47.776915358Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-09-29T21:13:47.776925859Z    -> 0.0014s
2025-09-29T21:13:47.776935979Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0014s) =================
2025-09-29T21:13:47.776946881Z 
2025-09-29T21:13:47.776956941Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-09-29T21:13:47.776967643Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-09-29T21:13:47.776978365Z -- create_table(:oauth_applications)
2025-09-29T21:13:47.776988635Z    -> 0.0004s
2025-09-29T21:13:47.776998826Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-09-29T21:13:47.777009157Z    -> 0.0002s
2025-09-29T21:13:47.777019177Z -- create_table(:oauth_access_grants)
2025-09-29T21:13:47.777027664Z    -> 0.0006s
2025-09-29T21:13:47.777035830Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-09-29T21:13:47.777045690Z    -> 0.0001s
2025-09-29T21:13:47.777055700Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-09-29T21:13:47.777066191Z    -> 0.0073s
2025-09-29T21:13:47.777076612Z -- create_table(:oauth_access_tokens)
2025-09-29T21:13:47.777086893Z    -> 0.0006s
2025-09-29T21:13:47.777097745Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-09-29T21:13:47.777108577Z    -> 0.0001s
2025-09-29T21:13:47.777118617Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-09-29T21:13:47.777128787Z    -> 0.0001s
2025-09-29T21:13:47.777136914Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-09-29T21:13:47.777145291Z    -> 0.0244s
2025-09-29T21:13:47.777153487Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-09-29T21:13:47.777161523Z    -> 0.0084s
2025-09-29T21:13:47.777169449Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-09-29T21:13:47.777177485Z    -> 0.0106s
2025-09-29T21:13:47.777185331Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0533s) ==================
2025-09-29T21:13:47.777193387Z 
2025-09-29T21:13:47.777201103Z Migrating to AddOwnerToApplication (20250408145956)
2025-09-29T21:13:47.777209089Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-09-29T21:13:47.777217225Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-09-29T21:13:47.777225212Z    -> 0.0011s
2025-09-29T21:13:47.777233027Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-09-29T21:13:47.777252947Z    -> 0.0008s
2025-09-29T21:13:47.777260933Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-09-29T21:13:47.777268980Z    -> 0.0002s
2025-09-29T21:13:47.777276886Z == 20250408145956 AddOwnerToApplication: migrated (0.0071s) ===================
2025-09-29T21:13:47.777284912Z 
2025-09-29T21:13:47.777292738Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-09-29T21:13:47.777300724Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-09-29T21:13:47.777308780Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-09-29T21:13:47.777316846Z    -> 0.0122s
2025-09-29T21:13:47.777324732Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0136s) ============
2025-09-29T21:13:47.777332798Z 
2025-09-29T21:13:47.777340574Z Migrating to AddQuotaToUsers (20250409125753)
2025-09-29T21:13:47.777349211Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-09-29T21:13:47.777357448Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-09-29T21:13:47.777365534Z    -> 0.0010s
2025-09-29T21:13:47.777374652Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-09-29T21:13:47.777384633Z    -> 0.0009s
2025-09-29T21:13:47.777394903Z == 20250409125753 AddQuotaToUsers: migrated (0.0033s) =========================
2025-09-29T21:13:47.777404763Z 
2025-09-29T21:13:47.777414723Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-09-29T21:13:47.777424533Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-09-29T21:13:47.777434864Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-09-29T21:13:47.777445826Z    -> 0.0132s
2025-09-29T21:13:47.777455175Z -- add_index(:model_files, :filename_lower)
2025-09-29T21:13:47.777464614Z    -> 0.0002s
2025-09-29T21:13:47.777473802Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0148s) 
2025-09-29T21:13:47.777483772Z 
2025-09-29T21:13:47.777493201Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-09-29T21:13:47.777502931Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-09-29T21:13:47.777513292Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-09-29T21:13:47.777522671Z    -> 0.0002s
2025-09-29T21:13:47.777532270Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0012s) ===================
2025-09-29T21:13:47.777541859Z 
2025-09-29T21:13:47.777551118Z Migrating to AddPreviewToModelFile (20250520111046)
2025-09-29T21:13:47.777574325Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-09-29T21:13:47.777585006Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-09-29T21:13:47.777595347Z    -> 0.0010s
2025-09-29T21:13:47.777605167Z == 20250520111046 AddPreviewToModelFile: migrated (0.0019s) ===================
2025-09-29T21:13:47.777615267Z 
2025-09-29T21:13:47.777625127Z Migrating to CreateAltchaSolutions (20250609210440)
2025-09-29T21:13:47.777634957Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-09-29T21:13:47.777644376Z -- create_table(:altcha_solutions)
2025-09-29T21:13:47.777653995Z    -> 0.0004s
2025-09-29T21:13:47.777664035Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-09-29T21:13:47.777674586Z    -> 0.0002s
2025-09-29T21:13:47.777685549Z == 20250609210440 CreateAltchaSolutions: migrated (0.0019s) ===================
2025-09-29T21:13:47.777696310Z 
2025-09-29T21:13:47.777705529Z Migrating to AddIndexableFields (20250620141805)
2025-09-29T21:13:47.777714757Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-09-29T21:13:47.777724397Z -- change_table(:models)
2025-09-29T21:13:47.777733555Z    -> 0.0026s
2025-09-29T21:13:47.777743175Z -- change_table(:creators)
2025-09-29T21:13:47.777753485Z    -> 0.0017s
2025-09-29T21:13:47.777765479Z -- change_table(:collections)
2025-09-29T21:13:47.777776231Z    -> 0.0019s
2025-09-29T21:13:47.777786582Z == 20250620141805 AddIndexableFields: migrated (0.0062s) ======================
2025-09-29T21:13:47.777796903Z 
2025-09-29T21:13:47.777808957Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-09-29T21:13:47.777819909Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-09-29T21:13:47.777830510Z -- change_column(:models, :indexable, :string)
2025-09-29T21:13:47.777840731Z    -> 0.0255s
2025-09-29T21:13:47.777850511Z -- change_column(:models, :ai_indexable, :string)
2025-09-29T21:13:47.777860601Z    -> 0.0189s
2025-09-29T21:13:47.777870952Z -- change_column(:creators, :indexable, :string)
2025-09-29T21:13:47.777881754Z    -> 0.0096s
2025-09-29T21:13:47.777892094Z -- change_column(:creators, :ai_indexable, :string)
2025-09-29T21:13:47.777902175Z    -> 0.0133s
2025-09-29T21:13:47.777911874Z -- change_column(:collections, :indexable, :string)
2025-09-29T21:13:47.777921884Z    -> 0.0547s
2025-09-29T21:13:47.777932155Z -- change_column(:collections, :ai_indexable, :string)
2025-09-29T21:13:47.777953368Z    -> 0.0126s
2025-09-29T21:13:47.777961404Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1350s) ======
2025-09-29T21:13:47.777969530Z 
2025-09-29T21:13:47.777977326Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-09-29T21:13:47.777985362Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-09-29T21:13:47.777993529Z -- change_table(:models)
2025-09-29T21:13:47.778001455Z    -> 0.0004s
2025-09-29T21:13:47.778009441Z -- change_table(:creators)
2025-09-29T21:13:47.778017357Z    -> 0.0003s
2025-09-29T21:13:47.778025253Z -- change_table(:collections)
2025-09-29T21:13:47.778033169Z    -> 0.0003s
2025-09-29T21:13:47.778041115Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0010s) =================
2025-09-29T21:13:47.778049221Z 
2025-09-29T21:13:47.778057087Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-09-29T21:13:47.778067387Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-09-29T21:13:47.778078069Z -- change_table(:links)
2025-09-29T21:13:47.778088320Z    -> 0.0002s
2025-09-29T21:13:47.778098340Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-09-29T21:13:47.778108470Z 
2025-09-29T21:13:47.778118320Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-09-29T21:13:47.778128641Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-09-29T21:13:47.778139453Z -- add_column(:links, :synced_at, :datetime)
2025-09-29T21:13:47.778149433Z    -> 0.0010s
2025-09-29T21:13:47.778161066Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0010s) ======================
2025-09-29T21:13:47.778171196Z 
2025-09-29T21:13:47.778181337Z Migrating to CreateFaspClientProviders (20250806142734)
2025-09-29T21:13:47.778191748Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-09-29T21:13:47.778201808Z -- create_table(:fasp_client_providers)
2025-09-29T21:13:47.778211868Z    -> 0.0459s
2025-09-29T21:13:47.778222159Z == 20250806142734 CreateFaspClientProviders: migrated (0.0459s) ===============
2025-09-29T21:13:47.778232690Z 
2025-09-29T21:13:47.778243001Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-09-29T21:13:47.778253182Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-09-29T21:13:47.778263112Z -- create_table(:fasp_client_event_subscriptions)
2025-09-29T21:13:47.778271418Z    -> 0.0135s
2025-09-29T21:13:47.778279364Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0136s) ======
2025-09-29T21:13:47.778287581Z 
2025-09-29T21:13:47.778308483Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-09-29T21:13:47.807443658Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-09-29T21:13:47.807481695Z -- create_table(:fasp_client_backfill_requests)
2025-09-29T21:13:47.807491595Z    -> 0.0053s
2025-09-29T21:13:47.807500202Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0053s) ========
2025-09-29T21:13:47.807508659Z 
2025-09-29T21:13:47.807516826Z Migrating to AddImagesToCreators (20250922155445)
2025-09-29T21:13:47.807525433Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-09-29T21:13:47.807533690Z -- add_column(:creators, :avatar_data, :json)
2025-09-29T21:13:47.807542507Z    -> 0.0010s
2025-09-29T21:13:47.807550624Z -- add_column(:creators, :banner_data, :json)
2025-09-29T21:13:47.807558770Z    -> 0.0009s
2025-09-29T21:13:47.807567217Z == 20250922155445 AddImagesToCreators: migrated (0.0019s) =====================
2025-09-29T21:13:47.807576185Z 
2025-09-29T21:13:47.994455239Z s6-rc: info: service init-manyfold-config successfully started
2025-09-29T21:13:47.994764592Z s6-rc: info: service init-config-end: starting
2025-09-29T21:13:47.998796381Z s6-rc: info: service init-config-end successfully started
2025-09-29T21:13:47.999075753Z s6-rc: info: service init-mods: starting
2025-09-29T21:13:48.003199086Z s6-rc: info: service init-mods successfully started
2025-09-29T21:13:48.003428728Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-09-29T21:13:48.021111754Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-09-29T21:13:48.021324753Z s6-rc: info: service init-mods-package-install: starting
2025-09-29T21:13:48.034353467Z [pkg-install-init] **** Installing all mod packages ****
2025-09-29T21:13:48.045534201Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-09-29T21:13:48.125998621Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-09-29T21:13:48.450833890Z (1/1) Installing redis (8.0.3-r0)
2025-09-29T21:13:48.459968173Z Executing redis-8.0.3-r0.pre-install
2025-09-29T21:13:48.672934435Z Executing redis-8.0.3-r0.post-install
2025-09-29T21:13:48.681484732Z Executing busybox-1.37.0-r19.trigger
2025-09-29T21:13:48.707705820Z OK: 427 MiB in 116 packages
2025-09-29T21:13:48.812756006Z s6-rc: info: service init-mods-package-install successfully started
2025-09-29T21:13:48.813095209Z s6-rc: info: service init-mods-end: starting
2025-09-29T21:13:48.824027131Z s6-rc: info: service init-mods-end successfully started
2025-09-29T21:13:48.824447768Z s6-rc: info: service init-custom-files: starting
2025-09-29T21:13:48.831799511Z [custom-init] No custom files found, skipping...
2025-09-29T21:13:48.837019603Z s6-rc: info: service init-custom-files successfully started
2025-09-29T21:13:48.837267421Z s6-rc: info: service init-services: starting
2025-09-29T21:13:48.841150881Z s6-rc: info: service init-services successfully started
2025-09-29T21:13:48.841394662Z s6-rc: info: service svc-mod-universal-redis: starting
2025-09-29T21:13:48.841654064Z s6-rc: info: service svc-manyfold: starting
2025-09-29T21:13:48.841935391Z s6-rc: info: service svc-cron: starting
2025-09-29T21:13:48.856597083Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-09-29T21:13:48.860650435Z s6-rc: info: service svc-cron successfully started
2025-09-29T21:13:48.864130793Z 281:C 29 Sep 2025 21:13:48.864 # WARNING Memory overcommit must be enabled! Without it, a background save or replication may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
2025-09-29T21:13:48.864204932Z 281:C 29 Sep 2025 21:13:48.864 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-09-29T21:13:48.864219571Z 281:C 29 Sep 2025 21:13:48.864 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=281, just started
2025-09-29T21:13:48.864231095Z 281:C 29 Sep 2025 21:13:48.864 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-09-29T21:13:48.865132760Z 281:M 29 Sep 2025 21:13:48.865 * monotonic clock: POSIX clock_gettime
2025-09-29T21:13:48.865792218Z 281:M 29 Sep 2025 21:13:48.865 * Running mode=standalone, port=6379.
2025-09-29T21:13:48.866260231Z 281:M 29 Sep 2025 21:13:48.866 * Server initialized
2025-09-29T21:13:48.866301844Z 281:M 29 Sep 2025 21:13:48.866 * Ready to accept connections tcp
2025-09-29T21:13:49.008039744Z 21:13:49 rails.1              | started with pid 301
2025-09-29T21:13:49.008074424Z 21:13:49 default_worker.1     | started with pid 302
2025-09-29T21:13:49.008099284Z 21:13:49 performance_worker.1 | started with pid 303
2025-09-29T21:13:50.811542735Z 21:13:50 performance_worker.1 | `/root` is not writable.
2025-09-29T21:13:50.811613658Z 21:13:50 performance_worker.1 | Bundler will use `/tmp/bundler20250929-303-j16ea8303' as your home directory temporarily.
2025-09-29T21:13:50.812159868Z 21:13:50 default_worker.1     | `/root` is not writable.
2025-09-29T21:13:50.812191020Z 21:13:50 default_worker.1     | Bundler will use `/tmp/bundler20250929-302-fptsu302' as your home directory temporarily.
2025-09-29T21:13:50.980934397Z 21:13:50 rails.1              | `/root` is not writable.
2025-09-29T21:13:50.980965329Z 21:13:50 rails.1              | Bundler will use `/tmp/bundler20250929-301-a9ubww301' as your home directory temporarily.
2025-09-29T21:13:52.288404010Z 21:13:52 default_worker.1     | Server: 7f90fe5f0e2a, Context: rails, Role: web, data: {cpu: {one_min: 3.52, five_min: 2.72, fifteen_min: 2.26}, memory: 0.187232256e9, disk: {available: 830971879424, total: 938656133120, used: 107684253696}}
2025-09-29T21:13:52.313217533Z 21:13:52 performance_worker.1 | Server: 7f90fe5f0e2a, Context: rails, Role: web, data: {cpu: {one_min: 3.52, five_min: 2.72, fifteen_min: 2.26}, memory: 0.178049024e9, disk: {available: 830971875328, total: 938656133120, used: 107684257792}}
2025-09-29T21:13:52.344349430Z 21:13:52 rails.1              | => Booting Puma
2025-09-29T21:13:52.344363137Z 21:13:52 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-09-29T21:13:52.344414070Z 21:13:52 rails.1              | => Run `bin/rails server --help` for more startup options
2025-09-29T21:13:54.543201333Z 21:13:54 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:54.544839422Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.544Z pid=302 tid=24e: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-29T21:13:54.549904621Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.549Z pid=302 tid=24e: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-29T21:13:54.551497899Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.551Z pid=302 tid=24e: Cron Jobs - added job with name clear-downloads in the namespace default
2025-09-29T21:13:54.605315835Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.604Z pid=302 tid=24e: Booted Rails 8.0.2.1 application in production environment
2025-09-29T21:13:54.605333491Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.605Z pid=302 tid=24e: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-29T21:13:54.605342920Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.605Z pid=302 tid=24e: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-29T21:13:54.605351738Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.605Z pid=302 tid=24e: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-29T21:13:54.608226105Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.608Z pid=302 tid=24e: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-09-29T21:13:54.614340667Z 21:13:54 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:54.615430792Z 21:13:54 performance_worker.1 | INFO  2025-09-29T21:13:54.615Z pid=303 tid=24f: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-29T21:13:54.673307171Z 21:13:54 performance_worker.1 | INFO  2025-09-29T21:13:54.672Z pid=303 tid=24f: Booted Rails 8.0.2.1 application in production environment
2025-09-29T21:13:54.673318864Z 21:13:54 performance_worker.1 | INFO  2025-09-29T21:13:54.673Z pid=303 tid=24f: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-29T21:13:54.673365729Z 21:13:54 performance_worker.1 | INFO  2025-09-29T21:13:54.673Z pid=303 tid=24f: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-29T21:13:54.673406781Z 21:13:54 performance_worker.1 | INFO  2025-09-29T21:13:54.673Z pid=303 tid=24f: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-29T21:13:54.676078100Z 21:13:54 performance_worker.1 | INFO  2025-09-29T21:13:54.675Z pid=303 tid=24f: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-09-29T21:13:54.789486516Z 21:13:54 rails.1              | Server: 7f90fe5f0e2a, Context: rails, Role: web, data: {cpu: {one_min: 3.52, five_min: 2.72, fifteen_min: 2.26}, memory: 0.170369024e9, disk: {available: 830971858944, total: 938656133120, used: 107684274176}}
2025-09-29T21:13:54.789527919Z 21:13:54 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:54.789537889Z 21:13:54 rails.1              | INFO  2025-09-29T21:13:54.599Z pid=301 tid=20d: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-29T21:13:54.789554994Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 4bb64f49-71b6-4907-adc0-56b931872022) to Sidekiq(high) with arguments: Model(id: integer, name: string, path: string, library_id: integer, created_at: datetime, updated_at: datetime, preview_file_id: integer, creator_id: integer, notes: text, caption: text, collection_id: integer, slug: string, license: string, public_id: string, name_lower: string, sensitive: boolean, indexable: string, ai_indexable: string, tag_list: )
2025-09-29T21:13:54.789570455Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: dc2a182c-023c-479e-a458-40ef2c9d8188) to Sidekiq(high) with arguments: Creator(id: integer, name: string, created_at: datetime, updated_at: datetime, notes: text, caption: text, slug: string, public_id: string, name_lower: string, indexable: string, ai_indexable: string, avatar_data: json, banner_data: json)
2025-09-29T21:13:54.789601207Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: bb4331fe-7774-40d8-9e82-4f242a69e6e4) to Sidekiq(high) with arguments: Collection(id: integer, name: string, notes: text, caption: text, created_at: datetime, updated_at: datetime, collection_id: integer, slug: string, public_id: string, name_lower: string, creator_id: integer, indexable: string, ai_indexable: string)
2025-09-29T21:13:54.789616628Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 1004497e-d9a5-4109-8df3-5364ec1a15f6) to Sidekiq(upgrade)
2025-09-29T21:13:54.789636899Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 036aafcd-9144-423f-8481-d978ae970898) to Sidekiq(upgrade)
2025-09-29T21:13:54.789700878Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 30eab7ab-fbc9-429e-9ba4-4de4871044fd) to Sidekiq(upgrade)
2025-09-29T21:13:54.794763952Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 5a2c6530-0b7f-425b-a4a5-2315b252e37a) to Sidekiq(upgrade)
2025-09-29T21:13:54.794788822Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 46aae7ea-528a-466f-982b-b09840547fd6) to Sidekiq(upgrade)
2025-09-29T21:13:54.794809484Z 21:13:54 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: ade24b9d-d89a-4358-9a93-cdd1c7409bdd) to Sidekiq(upgrade)
2025-09-29T21:13:54.794848733Z 21:13:54 rails.1              | [301] Puma starting in cluster mode...
2025-09-29T21:13:54.794858793Z 21:13:54 rails.1              | [301] * Puma version: 7.0.4 ("Romantic Warrior")
2025-09-29T21:13:54.794889104Z 21:13:54 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-29T21:13:54.794913293Z 21:13:54 rails.1              | [301] *  Min threads: 4
2025-09-29T21:13:54.794938895Z 21:13:54 rails.1              | [301] *  Max threads: 16
2025-09-29T21:13:54.794968945Z 21:13:54 rails.1              | [301] *  Environment: production
2025-09-29T21:13:54.794989196Z 21:13:54 rails.1              | [301] *   Master PID: 301
2025-09-29T21:13:54.795024387Z 21:13:54 rails.1              | [301] *      Workers: 4
2025-09-29T21:13:54.795048024Z 21:13:54 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-09-29T21:13:54.795100340Z 21:13:54 rails.1              | [301] * Preloading application
2025-09-29T21:13:54.795110861Z 21:13:54 rails.1              | [301] * Listening on http://[::]:3214
2025-09-29T21:13:54.795140400Z 21:13:54 rails.1              | [301] Use Ctrl-C to stop
2025-09-29T21:13:54.821217589Z 21:13:54 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-09-29T21:13:54.821262710Z 21:13:54 rails.1              | [301] - Worker 1 (PID: 390) booted in 0.01s, phase: 0
2025-09-29T21:13:54.821389675Z 21:13:54 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-09-29T21:13:54.823359532Z 21:13:54 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-09-29T21:13:54.883595612Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-09-29T21:13:54.884906201Z s6-rc: info: service svc-manyfold successfully started
2025-09-29T21:13:54.885195653Z s6-rc: info: service legacy-services: starting
2025-09-29T21:13:54.896259521Z s6-rc: info: service legacy-services successfully started
2025-09-29T21:13:54.896373821Z s6-rc: info: service ci-service-check: starting
2025-09-29T21:13:54.898431445Z 21:13:54 default_worker.1     | Server: 7f90fe5f0e2a, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.72, five_min: 2.77, fifteen_min: 2.28}, memory: 0.238440448e9, disk: {available: 830964461568, total: 938656133120, used: 107691671552}}
2025-09-29T21:13:54.898875048Z [ls.io-init] done.
2025-09-29T21:13:54.899290174Z s6-rc: info: service ci-service-check successfully started
2025-09-29T21:13:54.941261947Z 21:13:54 performance_worker.1 | Server: 7f90fe5f0e2a, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.72, five_min: 2.77, fifteen_min: 2.28}, memory: 0.22482944e9, disk: {available: 830964465664, total: 938656133120, used: 107691667456}}
2025-09-29T21:13:54.958101845Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.898Z pid=302 tid=h3q jid=a34a391a177a445e6a8e4bca class=Upgrade::GenerateSlugsJob: start
2025-09-29T21:13:54.963588072Z 21:13:54 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4bb64f49-71b6-4907-adc0-56b931872022] Performing Upgrade::GenerateSlugsJob (Job ID: 4bb64f49-71b6-4907-adc0-56b931872022) from Sidekiq(high) enqueued at 2025-09-29T21:13:54.617113651Z with arguments: Model(id: integer, name: string, path: string, library_id: integer, created_at: datetime, updated_at: datetime, preview_file_id: integer, creator_id: integer, notes: text, caption: text, collection_id: integer, slug: string, license: string, public_id: string, name_lower: string, sensitive: boolean, indexable: string, ai_indexable: string, tag_list: )
2025-09-29T21:13:54.966890111Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.963Z pid=302 tid=h5i jid=cdc9338d81e4f63bc12224f7 class=Upgrade::FixNilFileSizeValues: start
2025-09-29T21:13:54.969481208Z 21:13:54 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [1004497e-d9a5-4109-8df3-5364ec1a15f6] Performing Upgrade::FixNilFileSizeValues (Job ID: 1004497e-d9a5-4109-8df3-5364ec1a15f6) from Sidekiq(upgrade) enqueued at 2025-09-29T21:13:54.625946476Z
2025-09-29T21:13:54.979636557Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.899Z pid=302 tid=h5y jid=cb77aba5299fe18c4c7a85a2 class=Upgrade::GenerateSlugsJob: start
2025-09-29T21:13:54.990681116Z 21:13:54 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [bb4331fe-7774-40d8-9e82-4f242a69e6e4] Performing Upgrade::GenerateSlugsJob (Job ID: bb4331fe-7774-40d8-9e82-4f242a69e6e4) from Sidekiq(high) enqueued at 2025-09-29T21:13:54.623209515Z with arguments: Collection(id: integer, name: string, notes: text, caption: text, created_at: datetime, updated_at: datetime, collection_id: integer, slug: string, public_id: string, name_lower: string, creator_id: integer, indexable: string, ai_indexable: string)
2025-09-29T21:13:54.991930802Z 21:13:54 default_worker.1     | INFO  2025-09-29T21:13:54.898Z pid=302 tid=h66 jid=5ac91298121f6ee60a06c3f3 class=Upgrade::GenerateSlugsJob: start
2025-09-29T21:13:55.032160788Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [dc2a182c-023c-479e-a458-40ef2c9d8188] Performing Upgrade::GenerateSlugsJob (Job ID: dc2a182c-023c-479e-a458-40ef2c9d8188) from Sidekiq(high) enqueued at 2025-09-29T21:13:54.620367272Z with arguments: Creator(id: integer, name: string, created_at: datetime, updated_at: datetime, notes: text, caption: text, slug: string, public_id: string, name_lower: string, indexable: string, ai_indexable: string, avatar_data: json, banner_data: json)
2025-09-29T21:13:55.040777087Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [bb4331fe-7774-40d8-9e82-4f242a69e6e4] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.041735337Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [dc2a182c-023c-479e-a458-40ef2c9d8188] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.075828967Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [1004497e-d9a5-4109-8df3-5364ec1a15f6] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.091638971Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [bb4331fe-7774-40d8-9e82-4f242a69e6e4] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-29T21:13:55.169829584Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [bb4331fe-7774-40d8-9e82-4f242a69e6e4] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.065
2025-09-29T21:13:55.295342212Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [1004497e-d9a5-4109-8df3-5364ec1a15f6] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-29T21:13:55.300418724Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [1004497e-d9a5-4109-8df3-5364ec1a15f6] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.117
2025-09-29T21:13:55.312217913Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [dc2a182c-023c-479e-a458-40ef2c9d8188] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-29T21:13:55.312656726Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [dc2a182c-023c-479e-a458-40ef2c9d8188] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.221
2025-09-29T21:13:55.317381690Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4bb64f49-71b6-4907-adc0-56b931872022] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.411359501Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4bb64f49-71b6-4907-adc0-56b931872022] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-29T21:13:55.434424935Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4bb64f49-71b6-4907-adc0-56b931872022] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.108
2025-09-29T21:13:55.444384800Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [1004497e-d9a5-4109-8df3-5364ec1a15f6] Performed Upgrade::FixNilFileSizeValues (Job ID: 1004497e-d9a5-4109-8df3-5364ec1a15f6) from Sidekiq(upgrade) in 474.82ms
2025-09-29T21:13:55.454248281Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [dc2a182c-023c-479e-a458-40ef2c9d8188] Performed Upgrade::GenerateSlugsJob (Job ID: dc2a182c-023c-479e-a458-40ef2c9d8188) from Sidekiq(high) in 460.39ms
2025-09-29T21:13:55.455072520Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.454Z pid=302 tid=h5i jid=cdc9338d81e4f63bc12224f7 class=Upgrade::FixNilFileSizeValues elapsed=0.491: done
2025-09-29T21:13:55.455421974Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.455Z pid=302 tid=h66 jid=5ac91298121f6ee60a06c3f3 class=Upgrade::GenerateSlugsJob elapsed=0.556: done
2025-09-29T21:13:55.456706711Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [bb4331fe-7774-40d8-9e82-4f242a69e6e4] Performed Upgrade::GenerateSlugsJob (Job ID: bb4331fe-7774-40d8-9e82-4f242a69e6e4) from Sidekiq(high) in 429.65ms
2025-09-29T21:13:55.457026776Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.456Z pid=302 tid=h5i jid=c3f4c46a6c29b500ecf16d18 class=Upgrade::BackfillDataPackages: start
2025-09-29T21:13:55.459423902Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.458Z pid=302 tid=h5y jid=cb77aba5299fe18c4c7a85a2 class=Upgrade::GenerateSlugsJob elapsed=0.559: done
2025-09-29T21:13:55.459446077Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [4bb64f49-71b6-4907-adc0-56b931872022] Performed Upgrade::GenerateSlugsJob (Job ID: 4bb64f49-71b6-4907-adc0-56b931872022) from Sidekiq(high) in 496.01ms
2025-09-29T21:13:55.459490857Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.456Z pid=302 tid=h66 jid=8d1b025906d89d008f8aedfb class=Upgrade::DisambiguateUsernamesJob: start
2025-09-29T21:13:55.465299814Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [036aafcd-9144-423f-8481-d978ae970898] Performing Upgrade::BackfillDataPackages (Job ID: 036aafcd-9144-423f-8481-d978ae970898) from Sidekiq(upgrade) enqueued at 2025-09-29T21:13:54.626675975Z
2025-09-29T21:13:55.465956767Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.459Z pid=302 tid=h5y jid=7d2a691197a02a6995719bc4 class=Upgrade::UpdateActorsJob: start
2025-09-29T21:13:55.467038715Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [30eab7ab-fbc9-429e-9ba4-4de4871044fd] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 30eab7ab-fbc9-429e-9ba4-4de4871044fd) from Sidekiq(upgrade) enqueued at 2025-09-29T21:13:54.627306916Z
2025-09-29T21:13:55.467450294Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.464Z pid=302 tid=h3q jid=a34a391a177a445e6a8e4bca class=Upgrade::GenerateSlugsJob elapsed=0.566: done
2025-09-29T21:13:55.471883521Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [5a2c6530-0b7f-425b-a4a5-2315b252e37a] Performing Upgrade::UpdateActorsJob (Job ID: 5a2c6530-0b7f-425b-a4a5-2315b252e37a) from Sidekiq(upgrade) enqueued at 2025-09-29T21:13:54.628027898Z
2025-09-29T21:13:55.473100651Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [30eab7ab-fbc9-429e-9ba4-4de4871044fd] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.537081261Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.471Z pid=302 tid=h3q jid=37b2670781efc961882f0a89 class=Upgrade::FixParentCollections: start
2025-09-29T21:13:55.600798240Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [036aafcd-9144-423f-8481-d978ae970898] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.645706856Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [46aae7ea-528a-466f-982b-b09840547fd6] Performing Upgrade::FixParentCollections (Job ID: 46aae7ea-528a-466f-982b-b09840547fd6) from Sidekiq(upgrade) enqueued at 2025-09-29T21:13:54.628709089Z
2025-09-29T21:13:55.724961311Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [5a2c6530-0b7f-425b-a4a5-2315b252e37a] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.866244254Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [46aae7ea-528a-466f-982b-b09840547fd6] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:55.937718172Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [036aafcd-9144-423f-8481-d978ae970898] Performed Upgrade::BackfillDataPackages (Job ID: 036aafcd-9144-423f-8481-d978ae970898) from Sidekiq(upgrade) in 480.2ms
2025-09-29T21:13:55.940794115Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [30eab7ab-fbc9-429e-9ba4-4de4871044fd] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 30eab7ab-fbc9-429e-9ba4-4de4871044fd) from Sidekiq(upgrade) in 475.6ms
2025-09-29T21:13:55.954358007Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [5a2c6530-0b7f-425b-a4a5-2315b252e37a] Performed Upgrade::UpdateActorsJob (Job ID: 5a2c6530-0b7f-425b-a4a5-2315b252e37a) from Sidekiq(upgrade) in 487.37ms
2025-09-29T21:13:55.962140077Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [46aae7ea-528a-466f-982b-b09840547fd6] Performed Upgrade::FixParentCollections (Job ID: 46aae7ea-528a-466f-982b-b09840547fd6) from Sidekiq(upgrade) in 370.49ms
2025-09-29T21:13:55.973083773Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.952Z pid=302 tid=h5i jid=c3f4c46a6c29b500ecf16d18 class=Upgrade::BackfillDataPackages elapsed=0.495: done
2025-09-29T21:13:55.973167812Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.961Z pid=302 tid=h66 jid=8d1b025906d89d008f8aedfb class=Upgrade::DisambiguateUsernamesJob elapsed=0.505: done
2025-09-29T21:13:55.973760896Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.973Z pid=302 tid=h5i jid=c0607d0aade9530577fb8bad class=Upgrade::PruneOrphanedProblems: start
2025-09-29T21:13:55.984513688Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [ade24b9d-d89a-4358-9a93-cdd1c7409bdd] Performing Upgrade::PruneOrphanedProblems (Job ID: ade24b9d-d89a-4358-9a93-cdd1c7409bdd) from Sidekiq(upgrade) enqueued at 2025-09-29T21:13:54.629362926Z
2025-09-29T21:13:55.987689853Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.973Z pid=302 tid=h3q jid=37b2670781efc961882f0a89 class=Upgrade::FixParentCollections elapsed=0.501: done
2025-09-29T21:13:55.987711377Z 21:13:55 default_worker.1     | INFO  2025-09-29T21:13:55.972Z pid=302 tid=h5y jid=7d2a691197a02a6995719bc4 class=Upgrade::UpdateActorsJob elapsed=0.513: done
2025-09-29T21:13:55.989902569Z 21:13:55 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [ade24b9d-d89a-4358-9a93-cdd1c7409bdd] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-29T21:13:56.164234769Z 21:13:56 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [ade24b9d-d89a-4358-9a93-cdd1c7409bdd] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-29T21:13:56.167101010Z 21:13:56 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [ade24b9d-d89a-4358-9a93-cdd1c7409bdd] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.161
2025-09-29T21:13:56.189552518Z 21:13:56 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [ade24b9d-d89a-4358-9a93-cdd1c7409bdd] Performed Upgrade::PruneOrphanedProblems (Job ID: ade24b9d-d89a-4358-9a93-cdd1c7409bdd) from Sidekiq(upgrade) in 212.88ms
2025-09-29T21:13:56.191055565Z 21:13:56 default_worker.1     | INFO  2025-09-29T21:13:56.189Z pid=302 tid=h5i jid=c0607d0aade9530577fb8bad class=Upgrade::PruneOrphanedProblems elapsed=0.216: done
2025-09-29T21:14:24.848172248Z 21:14:24 rails.1              | [0600d0ba-32cb-4872-911c-96a899189cca] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1394,"duration":17.09,"view":0.0,"db":1.69,"@timestamp":"2025-09-29T21:14:24.847Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-29T21:14:25.837705914Z 21:14:25 rails.1              | [1d7be80d-a4e9-43d4-bbac-38c5e9fe9ff2] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":92928,"duration":970.13,"view":0.0,"db":29.68,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-29T21:14:25.837Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-29T21:14:25.925605736Z 21:14:25 rails.1              | [dd0807ba-a138-414b-8391-d81007e320f3] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1089,"duration":56.27,"view":0.0,"db":3.29,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-29T21:14:25.906Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-29T21:14:26.712200851Z 21:14:26 rails.1              | [3253fb0c-491e-4328-84f6-9ced301fb33c] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24025,"duration":761.47,"view":627.86,"db":71.46,"@timestamp":"2025-09-29T21:14:26.710Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-09-29T21:14:26.782145470Z 21:14:26 rails.1              | [fea2c4ff-f86c-4d2e-9221-525536eead71] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":436,"duration":28.27,"view":0.0,"db":0.13,"@timestamp":"2025-09-29T21:14:26.781Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-29T21:14:26.934019880Z 21:14:26 rails.1              | [f86524db-a495-44b1-829b-2d1e9cb0365d] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":1585,"duration":106.37,"view":0.0,"db":0.48,"location":"http://172.17.0.5:3214/","@timestamp":"2025-09-29T21:14:26.933Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-29T21:14:27.159962982Z 21:14:27 rails.1              | [702a08aa-8727-4167-8327-4c89733dd929] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":940,"duration":14.18,"view":0.0,"db":0.19,"location":"http://172.17.0.5:3214/users/edit","@timestamp":"2025-09-29T21:14:27.159Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-29T21:14:27.501663029Z 21:14:27 rails.1              | [78566112-98b2-44a3-8349-b282f7a7b726] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":8486,"duration":330.83,"view":200.23,"db":8.95,"@timestamp":"2025-09-29T21:14:27.501Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}