2025-09-26T09:57:01.356242560Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-09-26T09:57:01.356284896Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-09-26T09:57:01.418730660Z [mod-init] Running Docker Modification Logic
2025-09-26T09:57:01.659443545Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-09-26T09:57:02.338822594Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-09-26T09:57:02.704956443Z [mod-init] Installing linuxserver/mods:universal-redis
2025-09-26T09:57:02.730660843Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-09-26T09:57:02.731606668Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-09-26T09:57:02.753001089Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-09-26T09:57:02.757346790Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-09-26T09:57:02.757485309Z s6-rc: info: service fix-attrs: starting
2025-09-26T09:57:02.757720322Z s6-rc: info: service init-migrations: starting
2025-09-26T09:57:02.757972520Z s6-rc: info: service init-envfile: starting
2025-09-26T09:57:02.764253057Z [migrations] started
2025-09-26T09:57:02.764314170Z [migrations] no migrations found
2025-09-26T09:57:02.764679496Z s6-rc: info: service fix-attrs successfully started
2025-09-26T09:57:02.764878967Z s6-rc: info: service legacy-cont-init: starting
2025-09-26T09:57:02.765010783Z s6-rc: info: service init-migrations successfully started
2025-09-26T09:57:02.765130173Z s6-rc: info: service init-adduser: starting
2025-09-26T09:57:02.767142505Z s6-rc: info: service init-envfile successfully started
2025-09-26T09:57:02.771242972Z s6-rc: info: service legacy-cont-init successfully started
2025-09-26T09:57:02.787992981Z usermod: no changes
2025-09-26T09:57:02.793550823Z ───────────────────────────────────────
2025-09-26T09:57:02.793579641Z 
2025-09-26T09:57:02.793586725Z       ██╗     ███████╗██╗ ██████╗
2025-09-26T09:57:02.793594180Z       ██║     ██╔════╝██║██╔═══██╗
2025-09-26T09:57:02.793601655Z       ██║     ███████╗██║██║   ██║
2025-09-26T09:57:02.793608990Z       ██║     ╚════██║██║██║   ██║
2025-09-26T09:57:02.793616295Z       ███████╗███████║██║╚██████╔╝
2025-09-26T09:57:02.793623850Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-09-26T09:57:02.793631615Z 
2025-09-26T09:57:02.793638680Z    Brought to you by linuxserver.io
2025-09-26T09:57:02.793662948Z ───────────────────────────────────────
2025-09-26T09:57:02.793899926Z 
2025-09-26T09:57:02.793908242Z To support LSIO projects visit:
2025-09-26T09:57:02.793913974Z https://www.linuxserver.io/donate/
2025-09-26T09:57:02.793920206Z 
2025-09-26T09:57:02.793925637Z ───────────────────────────────────────
2025-09-26T09:57:02.793931569Z GID/UID
2025-09-26T09:57:02.793937080Z ───────────────────────────────────────
2025-09-26T09:57:02.798193802Z 
2025-09-26T09:57:02.798213983Z User UID:    911
2025-09-26T09:57:02.798222089Z User GID:    911
2025-09-26T09:57:02.798229223Z ───────────────────────────────────────
2025-09-26T09:57:02.800109459Z Linuxserver.io version: v0.124.0-ls105
2025-09-26T09:57:02.800409273Z Build-date: 2025-09-26T09:45:46+00:00
2025-09-26T09:57:02.800417750Z ───────────────────────────────────────
2025-09-26T09:57:02.800425506Z     
2025-09-26T09:57:02.816471346Z s6-rc: info: service init-adduser successfully started
2025-09-26T09:57:02.816668614Z s6-rc: info: service init-device-perms: starting
2025-09-26T09:57:02.821986542Z s6-rc: info: service init-device-perms successfully started
2025-09-26T09:57:02.822241115Z s6-rc: info: service init-os-end: starting
2025-09-26T09:57:02.823606465Z s6-rc: info: service init-os-end successfully started
2025-09-26T09:57:02.823765294Z s6-rc: info: service init-manyfold-config: starting
2025-09-26T09:57:02.824021140Z s6-rc: info: service init-config: starting
2025-09-26T09:57:02.825643086Z s6-rc: info: service init-config successfully started
2025-09-26T09:57:02.825836144Z s6-rc: info: service init-crontab-config: starting
2025-09-26T09:57:02.836544617Z s6-rc: info: service init-crontab-config successfully started
2025-09-26T09:57:02.851506265Z **** Running Manyfold database init. ****
2025-09-26T09:57:05.178430452Z `/root` is not writable.
2025-09-26T09:57:05.178608250Z Bundler will use `/tmp/bundler20250926-173-u18os5173' as your home directory temporarily.
2025-09-26T09:57:12.114952091Z Server: f5aaea356990, Context: rails, Role: web, data: {cpu: {one_min: 2.59, five_min: 2.27, fifteen_min: 2.19}, memory: 0.223645696e9, disk: {available: 843577155584, total: 938656133120, used: 95078977536}}
2025-09-26T09:57:12.114994186Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-09-26T09:57:12.115001140Z INFO  2025-09-26T09:57:10.184Z pid=173 tid=2il: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-26T09:57:12.115032213Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-09-26T09:57:12.115038305Z Migrating to CreateLibraries (20210130201037)
2025-09-26T09:57:12.115043866Z == 20210130201037 CreateLibraries: migrating ==================================
2025-09-26T09:57:12.115049498Z -- create_table(:libraries)
2025-09-26T09:57:12.115054939Z    -> 0.0028s
2025-09-26T09:57:12.115060510Z == 20210130201037 CreateLibraries: migrated (0.0029s) =========================
2025-09-26T09:57:12.115066111Z 
2025-09-26T09:57:12.115071502Z Migrating to CreateModels (20210130203243)
2025-09-26T09:57:12.115077013Z == 20210130203243 CreateModels: migrating =====================================
2025-09-26T09:57:12.115082544Z -- create_table(:models)
2025-09-26T09:57:12.115088095Z    -> 0.0009s
2025-09-26T09:57:12.115094137Z == 20210130203243 CreateModels: migrated (0.0009s) ============================
2025-09-26T09:57:12.115099659Z 
2025-09-26T09:57:12.115105350Z Migrating to CreateParts (20210205230918)
2025-09-26T09:57:12.115111112Z == 20210205230918 CreateParts: migrating ======================================
2025-09-26T09:57:12.115116623Z -- create_table(:parts)
2025-09-26T09:57:12.115122264Z    -> 0.0035s
2025-09-26T09:57:12.115127966Z == 20210205230918 CreateParts: migrated (0.0035s) =============================
2025-09-26T09:57:12.115133958Z 
2025-09-26T09:57:12.115139509Z Migrating to AddFieldsToParts (20210210153744)
2025-09-26T09:57:12.115144940Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-09-26T09:57:12.115150701Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-09-26T09:57:12.115156403Z    -> 0.0007s
2025-09-26T09:57:12.115162565Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-09-26T09:57:12.115168668Z    -> 0.0003s
2025-09-26T09:57:12.115174459Z == 20210210153744 AddFieldsToParts: migrated (0.0011s) ========================
2025-09-26T09:57:12.115180261Z 
2025-09-26T09:57:12.115186764Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-09-26T09:57:12.115192796Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-09-26T09:57:12.115198578Z -- create_table(:tags, {id: :integer})
2025-09-26T09:57:12.115204550Z    -> 0.0038s
2025-09-26T09:57:12.115210261Z -- create_table(:taggings, {id: :integer})
2025-09-26T09:57:12.115215913Z    -> 0.0017s
2025-09-26T09:57:12.115221634Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-26T09:57:12.115227616Z    -> 0.0002s
2025-09-26T09:57:12.115241364Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-26T09:57:12.115247346Z    -> 0.0021s
2025-09-26T09:57:12.115252877Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0080s) ===============
2025-09-26T09:57:12.115258819Z 
2025-09-26T09:57:12.115264641Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-09-26T09:57:12.115270282Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-09-26T09:57:12.115276314Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-09-26T09:57:12.115282246Z    -> 0.0004s
2025-09-26T09:57:12.115287637Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-26T09:57:12.115293379Z    -> 0.0005s
2025-09-26T09:57:12.115298960Z -- remove_foreign_key(:taggings, :tags)
2025-09-26T09:57:12.115304431Z    -> 0.1883s
2025-09-26T09:57:12.115309842Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-26T09:57:12.115315413Z    -> 0.0172s
2025-09-26T09:57:12.115321074Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-09-26T09:57:12.115326666Z    -> 0.0002s
2025-09-26T09:57:12.115332147Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-09-26T09:57:12.115337928Z    -> 0.0051s
2025-09-26T09:57:12.115343309Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-09-26T09:57:12.115349181Z    -> 0.0745s
2025-09-26T09:57:12.115354552Z == 20210212143002 AddMissingUniqueIndices: migrated (0.3212s) =================
2025-09-26T09:57:12.115360033Z 
2025-09-26T09:57:12.115365815Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-09-26T09:57:12.115371526Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-09-26T09:57:12.115377348Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-09-26T09:57:12.115382849Z    -> 0.0397s
2025-09-26T09:57:12.115388210Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1281s) ===========
2025-09-26T09:57:12.115394362Z 
2025-09-26T09:57:12.115399653Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-09-26T09:57:12.115405094Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-09-26T09:57:12.115410615Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-09-26T09:57:12.115416647Z    -> 0.0002s
2025-09-26T09:57:12.115422008Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-09-26T09:57:12.115434563Z 
2025-09-26T09:57:12.115439924Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-09-26T09:57:12.115445415Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-09-26T09:57:12.115450896Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0007s) ==============
2025-09-26T09:57:12.115456397Z 
2025-09-26T09:57:12.115461668Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-09-26T09:57:12.115467129Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-09-26T09:57:12.115472940Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-26T09:57:12.115478562Z    -> 0.0082s
2025-09-26T09:57:12.115485425Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-09-26T09:57:12.115491027Z    -> 0.0002s
2025-09-26T09:57:12.115496718Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-26T09:57:12.115502380Z    -> 0.0067s
2025-09-26T09:57:12.115507740Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-09-26T09:57:12.115513362Z    -> 0.0014s
2025-09-26T09:57:12.115518722Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-26T09:57:12.115524394Z    -> 0.0005s
2025-09-26T09:57:12.115529735Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-09-26T09:57:12.115535396Z    -> 0.0001s
2025-09-26T09:57:12.115540767Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-26T09:57:12.115546358Z    -> 0.0040s
2025-09-26T09:57:12.115551859Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-09-26T09:57:12.115557691Z    -> 0.0001s
2025-09-26T09:57:12.115563282Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-26T09:57:12.115569104Z    -> 0.0005s
2025-09-26T09:57:12.115574765Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-09-26T09:57:12.115580948Z    -> 0.0001s
2025-09-26T09:57:12.115586769Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-26T09:57:12.115592691Z    -> 0.0006s
2025-09-26T09:57:12.115598563Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-09-26T09:57:12.115604635Z    -> 0.0001s
2025-09-26T09:57:12.115610227Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-26T09:57:12.115616088Z    -> 0.0015s
2025-09-26T09:57:12.115621670Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-09-26T09:57:12.115634195Z    -> 0.0002s
2025-09-26T09:57:12.115639626Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0247s) =============
2025-09-26T09:57:12.115645157Z 
2025-09-26T09:57:12.115650428Z Migrating to AddPreviewPartToModel (20210220204055)
2025-09-26T09:57:12.115655949Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-09-26T09:57:12.115661490Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-09-26T09:57:12.115667041Z    -> 0.2613s
2025-09-26T09:57:12.115672412Z == 20210220204055 AddPreviewPartToModel: migrated (0.2613s) ===================
2025-09-26T09:57:12.115678224Z 
2025-09-26T09:57:12.115683975Z Migrating to CreateCreators (20210225232756)
2025-09-26T09:57:12.115689667Z == 20210225232756 CreateCreators: migrating ===================================
2025-09-26T09:57:12.115695158Z -- create_table(:creators)
2025-09-26T09:57:12.115700559Z    -> 0.0144s
2025-09-26T09:57:12.115705899Z == 20210225232756 CreateCreators: migrated (0.0145s) ==========================
2025-09-26T09:57:12.115711400Z 
2025-09-26T09:57:12.115717102Z Migrating to AddCreatorToModels (20210225232841)
2025-09-26T09:57:12.115722874Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-09-26T09:57:12.115728375Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-09-26T09:57:12.115733876Z    -> 0.0555s
2025-09-26T09:57:12.115739557Z == 20210225232841 AddCreatorToModels: migrated (0.0556s) ======================
2025-09-26T09:57:12.115745249Z 
2025-09-26T09:57:12.115750680Z Migrating to CreateLinks (20210301230017)
2025-09-26T09:57:12.115756141Z == 20210301230017 CreateLinks: migrating ======================================
2025-09-26T09:57:12.115761632Z -- create_table(:links)
2025-09-26T09:57:12.115767062Z    -> 0.0010s
2025-09-26T09:57:12.115772644Z == 20210301230017 CreateLinks: migrated (0.0010s) =============================
2025-09-26T09:57:12.115778355Z 
2025-09-26T09:57:12.115783866Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-09-26T09:57:12.115789317Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-09-26T09:57:12.115794889Z -- remove_column(:creators, :thingiverse_user, :string)
2025-09-26T09:57:12.115800660Z    -> 0.0730s
2025-09-26T09:57:12.115806332Z -- remove_column(:creators, :cults3d_user, :string)
2025-09-26T09:57:12.115811833Z    -> 0.0045s
2025-09-26T09:57:12.115817594Z -- remove_column(:creators, :mmf_user, :string)
2025-09-26T09:57:12.115823095Z    -> 0.0144s
2025-09-26T09:57:12.115835190Z -- remove_column(:creators, :cgtrader_user, :string)
2025-09-26T09:57:12.115841051Z    -> 0.0037s
2025-09-26T09:57:12.115859378Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.0981s) ==============
2025-09-26T09:57:12.115867445Z 
2025-09-26T09:57:12.115873266Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-09-26T09:57:12.115879268Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-09-26T09:57:12.115885471Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-09-26T09:57:12.115891463Z    -> 0.0575s
2025-09-26T09:57:12.115896814Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0576s) ==
2025-09-26T09:57:12.115902625Z 
2025-09-26T09:57:12.115907886Z Migrating to AddYUpToParts (20210318202638)
2025-09-26T09:57:12.115913608Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-09-26T09:57:12.115919159Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-09-26T09:57:12.115924840Z    -> 0.0149s
2025-09-26T09:57:12.115930622Z == 20210318202638 AddYUpToParts: migrated (0.0150s) ===========================
2025-09-26T09:57:12.115936383Z 
2025-09-26T09:57:12.115941824Z Migrating to CreateImages (20210321164508)
2025-09-26T09:57:12.115947526Z == 20210321164508 CreateImages: migrating =====================================
2025-09-26T09:57:12.115953318Z -- create_table(:images)
2025-09-26T09:57:12.115959059Z    -> 0.0164s
2025-09-26T09:57:12.115964971Z == 20210321164508 CreateImages: migrated (0.0164s) ============================
2025-09-26T09:57:12.115971063Z 
2025-09-26T09:57:12.115976344Z Migrating to CreateDelayedJobs (20210330215825)
2025-09-26T09:57:12.115981765Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-09-26T09:57:12.115987276Z -- create_table(:delayed_jobs)
2025-09-26T09:57:12.115993078Z    -> 0.0088s
2025-09-26T09:57:12.861546158Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-09-26T09:57:12.861587461Z    -> 0.0002s
2025-09-26T09:57:12.861599926Z == 20210330215825 CreateDelayedJobs: migrated (0.0090s) =======================
2025-09-26T09:57:12.861609866Z 
2025-09-26T09:57:12.861619305Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-09-26T09:57:12.861628824Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-09-26T09:57:12.861638393Z -- rename_table(:parts, :model_files)
2025-09-26T09:57:12.861648053Z    -> 0.0016s
2025-09-26T09:57:12.861657702Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-09-26T09:57:12.861704396Z    -> 0.0341s
2025-09-26T09:57:12.861715158Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0358s) =================
2025-09-26T09:57:12.861726230Z 
2025-09-26T09:57:12.861736341Z Migrating to RemoveImagesTable (20220106220519)
2025-09-26T09:57:12.861746672Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-09-26T09:57:12.861756872Z -- drop_table(:images)
2025-09-26T09:57:12.861766682Z    -> 0.0003s
2025-09-26T09:57:12.861777053Z == 20220106220519 RemoveImagesTable: migrated (0.0004s) =======================
2025-09-26T09:57:12.861787494Z 
2025-09-26T09:57:12.861797464Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-09-26T09:57:12.861808135Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-09-26T09:57:12.861818877Z -- table_exists?(:active_storage_blobs)
2025-09-26T09:57:12.861828927Z    -> 0.0001s
2025-09-26T09:57:12.861838997Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0001s) ======
2025-09-26T09:57:12.861849368Z 
2025-09-26T09:57:12.861859188Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-09-26T09:57:12.861868717Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-09-26T09:57:12.861878978Z -- table_exists?(:active_storage_blobs)
2025-09-26T09:57:12.861888397Z    -> 0.0001s
2025-09-26T09:57:12.861896854Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-09-26T09:57:12.861904920Z 
2025-09-26T09:57:12.861912756Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-09-26T09:57:12.861920822Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-09-26T09:57:12.861928888Z -- table_exists?(:active_storage_blobs)
2025-09-26T09:57:12.861936804Z    -> 0.0001s
2025-09-26T09:57:12.861944710Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0002s) 
2025-09-26T09:57:12.861952787Z 
2025-09-26T09:57:12.861960723Z Migrating to DeviseCreateUsers (20220614210023)
2025-09-26T09:57:12.861968869Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-09-26T09:57:12.861977156Z -- create_table(:users)
2025-09-26T09:57:12.861984991Z    -> 0.0012s
2025-09-26T09:57:12.861992847Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-09-26T09:57:12.862001154Z    -> 0.0017s
2025-09-26T09:57:12.862009020Z == 20220614210023 DeviseCreateUsers: migrated (0.0030s) =======================
2025-09-26T09:57:12.862017026Z 
2025-09-26T09:57:12.862024721Z Migrating to AddUsernameToUsers (20220614211256)
2025-09-26T09:57:12.862045032Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-09-26T09:57:12.862055193Z -- add_column(:users, :username, :string, {null: false})
2025-09-26T09:57:12.862063319Z    -> 0.0239s
2025-09-26T09:57:12.862071456Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-09-26T09:57:12.862079662Z    -> 0.0002s
2025-09-26T09:57:12.862087578Z == 20220614211256 AddUsernameToUsers: migrated (0.0242s) ======================
2025-09-26T09:57:12.862095594Z 
2025-09-26T09:57:12.862103300Z Migrating to AddAdminToUsers (20220614213902)
2025-09-26T09:57:12.862111236Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-09-26T09:57:12.862119242Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-26T09:57:12.862127328Z    -> 0.0006s
2025-09-26T09:57:12.862135274Z == 20220614213902 AddAdminToUsers: migrated (0.0006s) =========================
2025-09-26T09:57:12.862143320Z 
2025-09-26T09:57:12.862151186Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-09-26T09:57:12.862159583Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-09-26T09:57:12.862167719Z -- add_column(:users, :pagination_settings, :json, {default: {"models" => true, "creators" => true, "collections" => true, "per_page" => 12}})
2025-09-26T09:57:12.862177078Z    -> 0.0012s
2025-09-26T09:57:12.862185004Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0013s) =============
2025-09-26T09:57:12.862193030Z 
2025-09-26T09:57:12.862200756Z Migrating to CreateSettings (20220619174307)
2025-09-26T09:57:12.862208662Z == 20220619174307 CreateSettings: migrating ===================================
2025-09-26T09:57:12.862216918Z -- create_table(:settings)
2025-09-26T09:57:12.862224784Z    -> 0.0029s
2025-09-26T09:57:12.862232690Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-09-26T09:57:12.862240887Z    -> 0.0002s
2025-09-26T09:57:12.862248742Z == 20220619174307 CreateSettings: migrated (0.0032s) ==========================
2025-09-26T09:57:12.862256739Z 
2025-09-26T09:57:12.862264434Z Migrating to AddScaleFactorToModels (20220626152444)
2025-09-26T09:57:12.862272360Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-09-26T09:57:12.862280456Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-09-26T09:57:12.862288553Z    -> 0.0109s
2025-09-26T09:57:12.862296398Z == 20220626152444 AddScaleFactorToModels: migrated (0.0132s) ==================
2025-09-26T09:57:12.862306950Z 
2025-09-26T09:57:12.862314846Z Migrating to AddDigestToModelFiles (20220702202932)
2025-09-26T09:57:12.862333333Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-09-26T09:57:12.862341609Z -- add_column(:model_files, :digest, :string)
2025-09-26T09:57:12.862349646Z    -> 0.0026s
2025-09-26T09:57:12.862357972Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-09-26T09:57:12.862366630Z    -> 0.0002s
2025-09-26T09:57:12.862374486Z == 20220702202932 AddDigestToModelFiles: migrated (0.0050s) ===================
2025-09-26T09:57:12.862382833Z 
2025-09-26T09:57:12.862390618Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-09-26T09:57:12.862398564Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-09-26T09:57:12.862407151Z -- 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-26T09:57:12.862419146Z    -> 0.0009s
2025-09-26T09:57:12.862427082Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0013s) ==============
2025-09-26T09:57:12.862435108Z 
2025-09-26T09:57:12.862442863Z Migrating to CreateProblems (20221210001132)
2025-09-26T09:57:12.862450789Z == 20221210001132 CreateProblems: migrating ===================================
2025-09-26T09:57:12.862458886Z -- create_table(:problems)
2025-09-26T09:57:12.862466792Z    -> 0.0009s
2025-09-26T09:57:12.862474687Z == 20221210001132 CreateProblems: migrated (0.0013s) ==========================
2025-09-26T09:57:12.862482714Z 
2025-09-26T09:57:12.862490519Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-09-26T09:57:12.862498546Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-09-26T09:57:12.862506632Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0175s) ========
2025-09-26T09:57:12.862514678Z 
2025-09-26T09:57:12.862522394Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-09-26T09:57:12.862530330Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-09-26T09:57:12.862538416Z -- create_table(:favorites, {force: true})
2025-09-26T09:57:12.862546322Z    -> 0.0044s
2025-09-26T09:57:12.862554278Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-09-26T09:57:12.862562725Z    -> 0.0001s
2025-09-26T09:57:12.862570561Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-09-26T09:57:12.862579018Z    -> 0.0001s
2025-09-26T09:57:12.862586954Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-09-26T09:57:12.862605341Z    -> 0.0001s
2025-09-26T09:57:12.862613287Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0054s) ================
2025-09-26T09:57:12.862621473Z 
2025-09-26T09:57:12.862629359Z Migrating to MovePrintedToFavorites (20221220223040)
2025-09-26T09:57:12.862637315Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-09-26T09:57:12.862645321Z == 20221220223040 MovePrintedToFavorites: migrated (0.0626s) ==================
2025-09-26T09:57:12.862653427Z 
2025-09-26T09:57:12.862661123Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-09-26T09:57:12.862669079Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-09-26T09:57:12.862677095Z -- remove_column(:model_files, :printed, :boolean)
2025-09-26T09:57:12.862685041Z    -> 0.0278s
2025-09-26T09:57:12.862692997Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0282s) ===============
2025-09-26T09:57:12.862701194Z 
2025-09-26T09:57:12.862708899Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-09-26T09:57:12.862717516Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-09-26T09:57:12.862725643Z -- add_column(:models, :notes, :text)
2025-09-26T09:57:12.862733599Z    -> 0.0011s
2025-09-26T09:57:12.862741465Z -- add_column(:models, :excerpt, :text)
2025-09-26T09:57:12.862749371Z    -> 0.0022s
2025-09-26T09:57:12.862757327Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0033s) =================
2025-09-26T09:57:12.862765373Z 
2025-09-26T09:57:12.862773690Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-09-26T09:57:12.862781646Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-09-26T09:57:12.862789642Z -- add_column(:creators, :notes, :text)
2025-09-26T09:57:12.862797518Z    -> 0.0005s
2025-09-26T09:57:12.862805433Z -- add_column(:creators, :excerpt, :text)
2025-09-26T09:57:12.862813349Z    -> 0.0005s
2025-09-26T09:57:12.862821265Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-09-26T09:57:12.862829302Z 
2025-09-26T09:57:12.862837278Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-09-26T09:57:12.862845194Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-09-26T09:57:12.862853440Z -- add_column(:model_files, :notes, :text)
2025-09-26T09:57:12.862861897Z    -> 0.0005s
2025-09-26T09:57:12.862869973Z -- add_column(:model_files, :excerpt, :text)
2025-09-26T09:57:12.862877859Z    -> 0.0005s
2025-09-26T09:57:12.862895184Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0011s) =============
2025-09-26T09:57:12.862903270Z 
2025-09-26T09:57:12.862911006Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-09-26T09:57:12.862918942Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-09-26T09:57:12.862926938Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0207s) =================
2025-09-26T09:57:12.862934944Z 
2025-09-26T09:57:12.862942890Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-09-26T09:57:12.862951107Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-09-26T09:57:12.862959133Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-09-26T09:57:12.862967350Z    -> 0.0427s
2025-09-26T09:57:12.862975265Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0428s) =============
2025-09-26T09:57:12.862983171Z 
2025-09-26T09:57:12.862990877Z Migrating to RenameExcerptToCaption (20230222155910)
2025-09-26T09:57:12.862998753Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-09-26T09:57:12.863006659Z -- rename_column(:creators, :excerpt, :caption)
2025-09-26T09:57:12.863014855Z    -> 0.0218s
2025-09-26T09:57:12.863024124Z -- rename_column(:models, :excerpt, :caption)
2025-09-26T09:57:12.863032140Z    -> 0.0206s
2025-09-26T09:57:12.863040046Z -- rename_column(:model_files, :excerpt, :caption)
2025-09-26T09:57:12.863048423Z    -> 0.0194s
2025-09-26T09:57:12.863056729Z == 20230222155910 RenameExcerptToCaption: migrated (0.0641s) ==================
2025-09-26T09:57:12.863064756Z 
2025-09-26T09:57:12.863072491Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-09-26T09:57:12.863080688Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-09-26T09:57:12.863089025Z -- add_column(:libraries, :notes, :string)
2025-09-26T09:57:12.863097031Z    -> 0.0021s
2025-09-26T09:57:12.863104987Z -- add_column(:libraries, :caption, :string)
2025-09-26T09:57:13.330062250Z    -> 0.0007s
2025-09-26T09:57:13.330109024Z -- add_column(:libraries, :name, :string)
2025-09-26T09:57:13.330120698Z    -> 0.0005s
2025-09-26T09:57:13.330131028Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0122s) ============
2025-09-26T09:57:13.330139576Z 
2025-09-26T09:57:13.330147562Z Migrating to AddTagregexToLibrary (20230305180823)
2025-09-26T09:57:13.330155668Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-09-26T09:57:13.330163834Z -- add_column(:libraries, :tag_regex, :text)
2025-09-26T09:57:13.330203755Z    -> 0.0020s
2025-09-26T09:57:13.330212001Z == 20230305180823 AddTagregexToLibrary: migrated (0.0037s) ====================
2025-09-26T09:57:13.330220188Z 
2025-09-26T09:57:13.330228034Z Migrating to AddIconToLibrary (20230307215826)
2025-09-26T09:57:13.330236130Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-09-26T09:57:13.330244276Z -- add_column(:libraries, :icon, :text)
2025-09-26T09:57:13.330252353Z    -> 0.0019s
2025-09-26T09:57:13.330260299Z == 20230307215826 AddIconToLibrary: migrated (0.0034s) ========================
2025-09-26T09:57:13.330268345Z 
2025-09-26T09:57:13.330276151Z Migrating to CreateCollection (20230308004237)
2025-09-26T09:57:13.330284127Z == 20230308004237 CreateCollection: migrating =================================
2025-09-26T09:57:13.330292223Z -- create_table(:collections)
2025-09-26T09:57:13.330300249Z    -> 0.0028s
2025-09-26T09:57:13.330308155Z == 20230308004237 CreateCollection: migrated (0.0070s) ========================
2025-09-26T09:57:13.330316231Z 
2025-09-26T09:57:13.330324127Z Migrating to AddCollectionToModels (20230308005021)
2025-09-26T09:57:13.330332063Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-09-26T09:57:13.330340570Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-09-26T09:57:13.330350691Z    -> 0.0190s
2025-09-26T09:57:13.330360781Z == 20230308005021 AddCollectionToModels: migrated (0.0225s) ===================
2025-09-26T09:57:13.330371172Z 
2025-09-26T09:57:13.330380972Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-09-26T09:57:13.330390922Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-09-26T09:57:13.330399058Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0015s) =============
2025-09-26T09:57:13.330407114Z 
2025-09-26T09:57:13.330414880Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-09-26T09:57:13.330422896Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-09-26T09:57:13.330430942Z -- rename_column(:collections, :excerpt, :caption)
2025-09-26T09:57:13.330441073Z    -> 0.0040s
2025-09-26T09:57:13.330451073Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0041s) ========
2025-09-26T09:57:13.330461324Z 
2025-09-26T09:57:13.330471304Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-09-26T09:57:13.330481194Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-09-26T09:57:13.330490833Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-09-26T09:57:13.330499019Z 
2025-09-26T09:57:13.330518619Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-09-26T09:57:13.330528679Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-09-26T09:57:13.330539721Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-09-26T09:57:13.330551716Z    -> 0.0016s
2025-09-26T09:57:13.330562086Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0017s) ===============
2025-09-26T09:57:13.330573509Z 
2025-09-26T09:57:13.330583429Z Migrating to AddCollectionToCollections (20230324000000)
2025-09-26T09:57:13.330593961Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-09-26T09:57:13.330604462Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-09-26T09:57:13.330615083Z    -> 0.0061s
2025-09-26T09:57:13.330625935Z == 20230324000000 AddCollectionToCollections: migrated (0.0082s) ==============
2025-09-26T09:57:13.330636436Z 
2025-09-26T09:57:13.330646286Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-09-26T09:57:13.330657008Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-09-26T09:57:13.330666968Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0485s) =========
2025-09-26T09:57:13.330677449Z 
2025-09-26T09:57:13.330686998Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-09-26T09:57:13.330696347Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-09-26T09:57:13.330707149Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0073s) 
2025-09-26T09:57:13.330717580Z 
2025-09-26T09:57:13.330727349Z Migrating to AddSlugs (20230615135601)
2025-09-26T09:57:13.330737660Z == 20230615135601 AddSlugs: migrating =========================================
2025-09-26T09:57:13.330747760Z -- add_column(:models, :slug, :string)
2025-09-26T09:57:13.330757791Z    -> 0.0027s
2025-09-26T09:57:13.330766849Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-09-26T09:57:13.330775957Z    -> 0.0021s
2025-09-26T09:57:13.330783943Z -- add_column(:collections, :slug, :string)
2025-09-26T09:57:13.330792019Z    -> 0.0005s
2025-09-26T09:57:13.330799965Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-09-26T09:57:13.330808162Z    -> 0.0001s
2025-09-26T09:57:13.330816058Z -- add_column(:creators, :slug, :string)
2025-09-26T09:57:13.330823974Z    -> 0.0005s
2025-09-26T09:57:13.330831850Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-09-26T09:57:13.330840036Z    -> 0.0001s
2025-09-26T09:57:13.330860347Z == 20230615135601 AddSlugs: migrated (0.0066s) ================================
2025-09-26T09:57:13.330868574Z 
2025-09-26T09:57:13.330876620Z Migrating to GenerateSlugs (20230617222353)
2025-09-26T09:57:13.330884766Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-09-26T09:57:13.330894295Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-09-26T09:57:13.330903163Z 
2025-09-26T09:57:13.330912382Z Migrating to MakeNamesUnique (20230628194944)
2025-09-26T09:57:13.330923324Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-09-26T09:57:13.330932552Z == 20230628194944 MakeNamesUnique: migrated (0.0032s) =========================
2025-09-26T09:57:13.330940939Z 
2025-09-26T09:57:13.330948935Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-09-26T09:57:13.330959487Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-09-26T09:57:13.330969918Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-09-26T09:57:13.330980449Z    -> 0.0022s
2025-09-26T09:57:13.330990429Z -- remove_index(:creators, :slug)
2025-09-26T09:57:13.330999537Z    -> 0.0004s
2025-09-26T09:57:13.331007503Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-09-26T09:57:13.331015840Z    -> 0.0001s
2025-09-26T09:57:13.331023896Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-09-26T09:57:13.331032143Z    -> 0.0001s
2025-09-26T09:57:13.331040941Z -- remove_index(:collections, :slug)
2025-09-26T09:57:13.331050841Z    -> 0.0245s
2025-09-26T09:57:13.331060560Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-09-26T09:57:13.331073115Z    -> 0.0006s
2025-09-26T09:57:13.331086202Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0284s) ======
2025-09-26T09:57:13.331099469Z 
2025-09-26T09:57:13.331111984Z Migrating to AddSizeToModelFiles (20230707082403)
2025-09-26T09:57:13.331122305Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-09-26T09:57:13.331132565Z -- add_column(:model_files, :size, :integer)
2025-09-26T09:57:13.331143187Z    -> 0.0007s
2025-09-26T09:57:13.331153307Z == 20230707082403 AddSizeToModelFiles: migrated (0.0010s) =====================
2025-09-26T09:57:13.331163918Z 
2025-09-26T09:57:13.331173468Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-09-26T09:57:13.331183618Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-09-26T09:57:13.331193969Z -- change_column(:model_files, :size, :bigint)
2025-09-26T09:57:13.331217396Z    -> 0.0083s
2025-09-26T09:57:13.331227106Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0086s) ==================
2025-09-26T09:57:13.331236535Z 
2025-09-26T09:57:13.331246194Z Migrating to AddNoteToProblems (20230711111009)
2025-09-26T09:57:13.331256204Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-09-26T09:57:13.331267126Z -- add_column(:problems, :note, :string, {default: nil})
2025-09-26T09:57:13.331277898Z    -> 0.0013s
2025-09-26T09:57:13.331288309Z == 20230711111009 AddNoteToProblems: migrated (0.0023s) =======================
2025-09-26T09:57:13.331298830Z 
2025-09-26T09:57:13.331309031Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-09-26T09:57:13.331319552Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-09-26T09:57:13.331332057Z -- 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-26T09:57:13.331349642Z    -> 0.0006s
2025-09-26T09:57:13.331357939Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-09-26T09:57:13.331366526Z 
2025-09-26T09:57:13.331374532Z Migrating to AddLicenseToModel (20240127143358)
2025-09-26T09:57:13.331382779Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-09-26T09:57:13.331391046Z -- add_column(:models, :license, :string)
2025-09-26T09:57:13.331398992Z    -> 0.0005s
2025-09-26T09:57:13.331406868Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-09-26T09:57:13.331415284Z 
2025-09-26T09:57:13.331423050Z Migrating to AddIgnoredToProblems (20240131134832)
2025-09-26T09:57:13.331431337Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-09-26T09:57:13.331439383Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-09-26T09:57:13.331447700Z    -> 0.0006s
2025-09-26T09:57:13.331455836Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-09-26T09:57:13.331466377Z 
2025-09-26T09:57:13.331474163Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-09-26T09:57:13.331482891Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-09-26T09:57:13.331490967Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-09-26T09:57:13.331511989Z    -> 0.0106s
2025-09-26T09:57:13.331519965Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0106s) ======
2025-09-26T09:57:13.331528072Z 
2025-09-26T09:57:13.331535817Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-09-26T09:57:13.331543803Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-09-26T09:57:13.331551849Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-09-26T09:57:13.331560767Z    -> 0.0007s
2025-09-26T09:57:13.331568653Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0007s) ===============
2025-09-26T09:57:13.331576699Z 
2025-09-26T09:57:13.331584575Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-09-26T09:57:13.331592792Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-09-26T09:57:13.331600798Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-09-26T09:57:13.331609005Z    -> 0.0002s
2025-09-26T09:57:13.331616920Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-09-26T09:57:13.331625317Z    -> 0.0009s
2025-09-26T09:57:13.331633223Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-09-26T09:57:13.331641610Z    -> 0.0001s
2025-09-26T09:57:13.331649586Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-09-26T09:57:13.331658194Z    -> 0.0044s
2025-09-26T09:57:13.832276569Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0058s) =================
2025-09-26T09:57:13.832313113Z 
2025-09-26T09:57:13.832319966Z Migrating to CreateFlipperTables (20240306095646)
2025-09-26T09:57:13.832325708Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-09-26T09:57:13.832331259Z -- create_table(:flipper_features)
2025-09-26T09:57:13.832336750Z    -> 0.0028s
2025-09-26T09:57:13.832342642Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-09-26T09:57:13.832348444Z    -> 0.0048s
2025-09-26T09:57:13.832353945Z -- create_table(:flipper_gates)
2025-09-26T09:57:13.832359626Z    -> 0.0003s
2025-09-26T09:57:13.832365328Z -- 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-26T09:57:13.832371210Z    -> 0.0001s
2025-09-26T09:57:13.832376640Z == 20240306095646 CreateFlipperTables: migrated (0.0081s) =====================
2025-09-26T09:57:13.832409116Z 
2025-09-26T09:57:13.832414627Z Migrating to RolifyCreateRoles (20240319155251)
2025-09-26T09:57:13.832420138Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-09-26T09:57:13.832425689Z -- create_table(:roles)
2025-09-26T09:57:13.832431070Z    -> 0.0380s
2025-09-26T09:57:13.832436852Z -- create_table(:users_roles, {id: false})
2025-09-26T09:57:13.832442473Z    -> 0.0005s
2025-09-26T09:57:13.832447934Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-09-26T09:57:13.832454327Z    -> 0.0048s
2025-09-26T09:57:13.832459788Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-09-26T09:57:13.832466111Z    -> 0.0002s
2025-09-26T09:57:13.832471522Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-09-26T09:57:13.832477193Z    -> 0.0001s
2025-09-26T09:57:13.832483325Z == 20240319155251 RolifyCreateRoles: migrated (0.0595s) =======================
2025-09-26T09:57:13.832488836Z 
2025-09-26T09:57:13.832494137Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-09-26T09:57:13.832499598Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-09-26T09:57:13.832505490Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0066s) ==================
2025-09-26T09:57:13.832510991Z 
2025-09-26T09:57:13.832516362Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-09-26T09:57:13.832521793Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-09-26T09:57:13.832527504Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-09-26T09:57:13.832533015Z    -> 0.0279s
2025-09-26T09:57:13.832538376Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0292s) ====================
2025-09-26T09:57:13.832543887Z 
2025-09-26T09:57:13.832549178Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-09-26T09:57:13.832554649Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-09-26T09:57:13.832560190Z -- add_column(:users, :reset_password_token, :string)
2025-09-26T09:57:13.832565691Z    -> 0.0012s
2025-09-26T09:57:13.832571763Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-09-26T09:57:13.832578717Z    -> 0.0002s
2025-09-26T09:57:13.832584489Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0034s) ============
2025-09-26T09:57:13.832590792Z 
2025-09-26T09:57:13.832596854Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-09-26T09:57:13.832602726Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-09-26T09:57:13.832615451Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0256s) ==============
2025-09-26T09:57:13.832621724Z 
2025-09-26T09:57:13.832627466Z Migrating to AddRememberableToUsers (20240410221112)
2025-09-26T09:57:13.832633117Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-09-26T09:57:13.832638848Z -- add_column(:users, :remember_created_at, :datetime)
2025-09-26T09:57:13.832644570Z    -> 0.0032s
2025-09-26T09:57:13.832650281Z == 20240410221112 AddRememberableToUsers: migrated (0.0044s) ==================
2025-09-26T09:57:13.832655803Z 
2025-09-26T09:57:13.832661674Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-09-26T09:57:13.832667155Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-09-26T09:57:13.832673037Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-09-26T09:57:13.832678518Z    -> 0.0006s
2025-09-26T09:57:13.832684190Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0020s) ===========
2025-09-26T09:57:13.832689781Z 
2025-09-26T09:57:13.832695503Z Migrating to DropDelayedJobs (20240418112821)
2025-09-26T09:57:13.832701364Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-09-26T09:57:13.832706885Z -- drop_table(:delayed_jobs)
2025-09-26T09:57:13.832712547Z    -> 0.0019s
2025-09-26T09:57:13.832718308Z == 20240418112821 DropDelayedJobs: migrated (0.0121s) =========================
2025-09-26T09:57:13.832724100Z 
2025-09-26T09:57:13.832729461Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-09-26T09:57:13.832734912Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-09-26T09:57:13.832740473Z -- add_column(:users, :interface_language, :string)
2025-09-26T09:57:13.832745954Z    -> 0.0007s
2025-09-26T09:57:13.832751626Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0040s) =============
2025-09-26T09:57:13.832757157Z 
2025-09-26T09:57:13.832762828Z Migrating to AddLockableToUsers (20240610120318)
2025-09-26T09:57:13.832768510Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-09-26T09:57:13.832774311Z -- change_table(:users)
2025-09-26T09:57:13.832780223Z    -> 0.0017s
2025-09-26T09:57:13.832785644Z == 20240610120318 AddLockableToUsers: migrated (0.0020s) ======================
2025-09-26T09:57:13.832791175Z 
2025-09-26T09:57:13.832796506Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-09-26T09:57:13.832801987Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-09-26T09:57:13.832807638Z -- add_column(:model_files, :attachment_data, :json)
2025-09-26T09:57:13.832819632Z    -> 0.0006s
2025-09-26T09:57:13.832825083Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0009s) ===========
2025-09-26T09:57:13.832830595Z 
2025-09-26T09:57:13.832835915Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-09-26T09:57:13.832841867Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-09-26T09:57:13.832847428Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0217s) ==================
2025-09-26T09:57:13.832852960Z 
2025-09-26T09:57:13.832858401Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-09-26T09:57:13.832863872Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-09-26T09:57:13.832869643Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-09-26T09:57:13.832875325Z    -> 0.0007s
2025-09-26T09:57:13.832881407Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0026s) ============
2025-09-26T09:57:13.832887118Z 
2025-09-26T09:57:13.832892449Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-09-26T09:57:13.832897910Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-09-26T09:57:13.832904022Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-09-26T09:57:13.832909814Z    -> 0.0007s
2025-09-26T09:57:13.832915415Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-09-26T09:57:13.832921087Z    -> 0.0006s
2025-09-26T09:57:13.832926949Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-09-26T09:57:13.832932620Z    -> 0.0006s
2025-09-26T09:57:13.832938231Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-09-26T09:57:13.832943953Z    -> 0.0049s
2025-09-26T09:57:13.832949694Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-09-26T09:57:13.832955226Z    -> 0.0008s
2025-09-26T09:57:13.832960616Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0088s) ====================
2025-09-26T09:57:13.832966358Z 
2025-09-26T09:57:13.832971949Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-09-26T09:57:13.832980316Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-09-26T09:57:13.832986458Z -- remove_index(:libraries, :path)
2025-09-26T09:57:13.832991909Z    -> 0.0011s
2025-09-26T09:57:13.832997681Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0018s) ================
2025-09-26T09:57:13.833003272Z 
2025-09-26T09:57:13.833008603Z Migrating to CreateFederailsActors (20240727113215)
2025-09-26T09:57:13.833014355Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-09-26T09:57:13.833026329Z -- create_table(:federails_actors)
2025-09-26T09:57:13.833031810Z    -> 0.0008s
2025-09-26T09:57:13.833037301Z -- foreign_key_exists?(:federails_actors, :users)
2025-09-26T09:57:13.833042982Z    -> 0.0016s
2025-09-26T09:57:13.833048834Z -- remove_foreign_key(:federails_actors, :users)
2025-09-26T09:57:13.833054295Z    -> 0.0127s
2025-09-26T09:57:13.833059716Z -- remove_index(:federails_actors, :user_id)
2025-09-26T09:57:13.833065157Z    -> 0.0004s
2025-09-26T09:57:13.833070848Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-09-26T09:57:13.833076740Z    -> 0.0001s
2025-09-26T09:57:13.833082422Z -- add_foreign_key(:federails_actors, :users)
2025-09-26T09:57:13.833088314Z    -> 0.0099s
2025-09-26T09:57:13.833094155Z == 20240727113215 CreateFederailsActors: migrated (0.0265s) ===================
2025-09-26T09:57:13.833100488Z 
2025-09-26T09:57:13.833106240Z Migrating to CreateFederailsFollowings (20240727113216)
2025-09-26T09:57:13.833112041Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-09-26T09:57:13.833117853Z -- create_table(:federails_followings)
2025-09-26T09:57:13.833123464Z    -> 0.0013s
2025-09-26T09:57:13.833129066Z == 20240727113216 CreateFederailsFollowings: migrated (0.0013s) ===============
2025-09-26T09:57:13.833134817Z 
2025-09-26T09:57:13.833140378Z Migrating to CreateFederailsActivities (20240727113217)
2025-09-26T09:57:13.833146040Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-09-26T09:57:13.833151591Z -- create_table(:federails_activities)
2025-09-26T09:57:13.833157022Z    -> 0.0091s
2025-09-26T09:57:13.833162463Z == 20240727113217 CreateFederailsActivities: migrated (0.0092s) ===============
2025-09-26T09:57:13.833168064Z 
2025-09-26T09:57:13.833173375Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-09-26T09:57:13.833178846Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-09-26T09:57:13.833184708Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-09-26T09:57:13.833190359Z    -> 0.0082s
2025-09-26T09:57:13.833195790Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-09-26T09:57:13.833201291Z    -> 0.0004s
2025-09-26T09:57:13.833206752Z -- change_table(:federails_actors)
2025-09-26T09:57:13.833212163Z    -> 0.0064s
2025-09-26T09:57:13.833217594Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0150s) =======
2025-09-26T09:57:13.833229949Z 
2025-09-26T09:57:13.833235500Z Migrating to CreateFederailsActors (20240731165647)
2025-09-26T09:57:13.833241261Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-09-26T09:57:13.833246913Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-09-26T09:57:13.833252454Z 
2025-09-26T09:57:13.833258045Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-09-26T09:57:13.833263777Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-09-26T09:57:13.833269288Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-09-26T09:57:13.833274819Z 
2025-09-26T09:57:13.833280460Z Migrating to BackfillActivities (20240805111500)
2025-09-26T09:57:13.833286162Z == 20240805111500 BackfillActivities: migrating ===============================
2025-09-26T09:57:13.833291673Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-09-26T09:57:13.833297194Z 
2025-09-26T09:57:13.833302515Z Migrating to CreateCaberRelations (20240827155630)
2025-09-26T09:57:13.833307976Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-09-26T09:57:13.833313497Z -- create_table(:caber_relations)
2025-09-26T09:57:13.833318938Z    -> 0.0389s
2025-09-26T09:57:13.833324439Z == 20240827155630 CreateCaberRelations: migrated (0.0390s) ====================
2025-09-26T09:57:13.833330060Z 
2025-09-26T09:57:13.833335391Z Migrating to AddDefaultAccessControls (20240830121749)
2025-09-26T09:57:13.833340842Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-09-26T09:57:13.833346343Z == 20240830121749 AddDefaultAccessControls: migrated (0.0578s) ================
2025-09-26T09:57:13.833351844Z 
2025-09-26T09:57:13.833357766Z Migrating to RenameDefaultRoles (20240830151650)
2025-09-26T09:57:14.490379003Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-09-26T09:57:14.490412381Z == 20240830151650 RenameDefaultRoles: migrated (0.0405s) ======================
2025-09-26T09:57:14.490422080Z 
2025-09-26T09:57:14.490430547Z Migrating to AddPublicIDsToModels (20240904151944)
2025-09-26T09:57:14.490438794Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-09-26T09:57:14.490447071Z -- add_column(:models, :public_id, :string)
2025-09-26T09:57:14.490455157Z    -> 0.0008s
2025-09-26T09:57:14.490463393Z -- add_index(:models, :public_id)
2025-09-26T09:57:14.490472061Z    -> 0.0025s
2025-09-26T09:57:14.490480478Z -- add_column(:model_files, :public_id, :string)
2025-09-26T09:57:14.490488774Z    -> 0.0007s
2025-09-26T09:57:14.490522893Z -- add_index(:model_files, :public_id)
2025-09-26T09:57:14.490531030Z    -> 0.0002s
2025-09-26T09:57:14.490539046Z -- add_column(:problems, :public_id, :string)
2025-09-26T09:57:14.490547112Z    -> 0.0007s
2025-09-26T09:57:14.490555028Z -- add_index(:problems, :public_id)
2025-09-26T09:57:14.490563114Z    -> 0.0001s
2025-09-26T09:57:14.490571090Z -- add_column(:creators, :public_id, :string)
2025-09-26T09:57:14.490579116Z    -> 0.0007s
2025-09-26T09:57:14.490587062Z -- add_index(:creators, :public_id)
2025-09-26T09:57:14.490595008Z    -> 0.0002s
2025-09-26T09:57:14.490602954Z -- add_column(:collections, :public_id, :string)
2025-09-26T09:57:14.490611011Z    -> 0.0007s
2025-09-26T09:57:14.490619137Z -- add_index(:collections, :public_id)
2025-09-26T09:57:14.490627233Z    -> 0.0001s
2025-09-26T09:57:14.490635259Z -- add_column(:libraries, :public_id, :string)
2025-09-26T09:57:14.490643286Z    -> 0.0007s
2025-09-26T09:57:14.490651242Z -- add_index(:libraries, :public_id)
2025-09-26T09:57:14.490659268Z    -> 0.0002s
2025-09-26T09:57:14.490667224Z == 20240904151944 AddPublicIDsToModels: migrated (0.0077s) ====================
2025-09-26T09:57:14.490675390Z 
2025-09-26T09:57:14.490683206Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-09-26T09:57:14.490691342Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-09-26T09:57:14.490699439Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:14.490707565Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0486s) ==============
2025-09-26T09:57:14.490715681Z 
2025-09-26T09:57:14.490723427Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-09-26T09:57:14.490731473Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-09-26T09:57:14.490739549Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-09-26T09:57:14.490747646Z 
2025-09-26T09:57:14.490755472Z Migrating to DeduplicateRoles (20240923114515)
2025-09-26T09:57:14.490763438Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-09-26T09:57:14.490771484Z == 20240923114515 DeduplicateRoles: migrated (0.1433s) ========================
2025-09-26T09:57:14.490779570Z 
2025-09-26T09:57:14.490787336Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-09-26T09:57:14.490795342Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-09-26T09:57:14.490803408Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-26T09:57:14.490822096Z    -> 0.1541s
2025-09-26T09:57:14.490831715Z -- add_index(:models, :name_lower)
2025-09-26T09:57:14.490839781Z    -> 0.0002s
2025-09-26T09:57:14.490847747Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-26T09:57:14.490856134Z    -> 0.0068s
2025-09-26T09:57:14.490864150Z -- add_index(:creators, :name_lower)
2025-09-26T09:57:14.490872227Z    -> 0.0002s
2025-09-26T09:57:14.490880082Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-09-26T09:57:14.490888590Z    -> 0.0085s
2025-09-26T09:57:14.490896786Z -- add_index(:collections, :name_lower)
2025-09-26T09:57:14.490905273Z    -> 0.0001s
2025-09-26T09:57:14.490913139Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1701s) =============
2025-09-26T09:57:14.490921245Z 
2025-09-26T09:57:14.490929001Z Migrating to AddKeypairToActors (20240926162407)
2025-09-26T09:57:14.490936997Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-09-26T09:57:14.490945043Z -- change_table(:federails_actors)
2025-09-26T09:57:14.490952999Z    -> 0.0018s
2025-09-26T09:57:14.490960965Z == 20240926162407 AddKeypairToActors: migrated (0.0019s) ======================
2025-09-26T09:57:14.490969643Z 
2025-09-26T09:57:14.490977358Z Migrating to AddUuids (20241004194445)
2025-09-26T09:57:14.490985294Z == 20241004194445 AddUuids: migrating =========================================
2025-09-26T09:57:14.490993361Z -- change_table(:federails_actors)
2025-09-26T09:57:14.491001276Z    -> 0.0029s
2025-09-26T09:57:14.491009182Z -- change_table(:federails_activities)
2025-09-26T09:57:14.491017138Z    -> 0.0009s
2025-09-26T09:57:14.491025405Z -- change_table(:federails_followings)
2025-09-26T09:57:14.491033341Z    -> 0.0009s
2025-09-26T09:57:14.491041257Z == 20241004194445 AddUuids: migrated (0.0048s) ================================
2025-09-26T09:57:14.491049363Z 
2025-09-26T09:57:14.491057129Z Migrating to CreateComments (20241007182824)
2025-09-26T09:57:14.491065105Z == 20241007182824 CreateComments: migrating ===================================
2025-09-26T09:57:14.491073302Z -- create_table(:comments)
2025-09-26T09:57:14.491081197Z    -> 0.0022s
2025-09-26T09:57:14.491089163Z == 20241007182824 CreateComments: migrated (0.0022s) ==========================
2025-09-26T09:57:14.491097250Z 
2025-09-26T09:57:14.491105176Z Migrating to AddSystemToComments (20241009122540)
2025-09-26T09:57:14.491113192Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-09-26T09:57:14.491145296Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-09-26T09:57:14.491153784Z    -> 0.0009s
2025-09-26T09:57:14.491161760Z == 20241009122540 AddSystemToComments: migrated (0.0009s) =====================
2025-09-26T09:57:14.491170066Z 
2025-09-26T09:57:14.491178072Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-09-26T09:57:14.491186319Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-09-26T09:57:14.491194425Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0016s) ============
2025-09-26T09:57:14.491202923Z 
2025-09-26T09:57:14.491212111Z Migrating to AddOmniauthToUsers (20241015090803)
2025-09-26T09:57:14.491220428Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-09-26T09:57:14.491229887Z -- add_column(:users, :auth_provider, :string)
2025-09-26T09:57:14.491238334Z    -> 0.0010s
2025-09-26T09:57:14.491246400Z -- add_column(:users, :auth_uid, :string)
2025-09-26T09:57:14.491254907Z    -> 0.0007s
2025-09-26T09:57:14.491262903Z == 20241015090803 AddOmniauthToUsers: migrated (0.0018s) ======================
2025-09-26T09:57:14.491271050Z 
2025-09-26T09:57:14.491279036Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-09-26T09:57:14.491287423Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-09-26T09:57:14.491296140Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-09-26T09:57:14.491304627Z    -> 0.0008s
2025-09-26T09:57:14.491312824Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-09-26T09:57:14.491321040Z    -> 0.0007s
2025-09-26T09:57:14.491329427Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0015s) =====
2025-09-26T09:57:14.491337764Z 
2025-09-26T09:57:14.491346201Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-09-26T09:57:14.491354257Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-09-26T09:57:14.491362594Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-09-26T09:57:14.491370710Z    -> 0.0009s
2025-09-26T09:57:14.491378797Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0009s) ======
2025-09-26T09:57:14.491386913Z 
2025-09-26T09:57:14.491394659Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-09-26T09:57:14.491402665Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-09-26T09:57:14.491410811Z -- change_table(:users)
2025-09-26T09:57:14.491420611Z    -> 0.0010s
2025-09-26T09:57:14.491428597Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-09-26T09:57:14.491447285Z 
2025-09-26T09:57:14.491455170Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-09-26T09:57:14.491463347Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-09-26T09:57:14.491471433Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0041s) =================
2025-09-26T09:57:14.491479540Z 
2025-09-26T09:57:14.491487315Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-09-26T09:57:14.491495331Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-09-26T09:57:14.491503408Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-09-26T09:57:14.491511875Z    -> 0.0009s
2025-09-26T09:57:14.491519901Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-09-26T09:57:14.491528338Z    -> 0.0012s
2025-09-26T09:57:14.491536244Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-09-26T09:57:14.491544560Z    -> 0.0004s
2025-09-26T09:57:14.491552486Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-09-26T09:57:14.491560743Z    -> 0.0023s
2025-09-26T09:57:14.491568589Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-09-26T09:57:14.491576866Z    -> 0.0008s
2025-09-26T09:57:14.491584801Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-09-26T09:57:14.491593088Z    -> 0.0007s
2025-09-26T09:57:14.491601465Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-09-26T09:57:14.491609922Z    -> 0.0004s
2025-09-26T09:57:14.491617928Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0069s) ===================
2025-09-26T09:57:14.491626105Z 
2025-09-26T09:57:14.491633860Z Migrating to AddInProgressToProblems (20241105121830)
2025-09-26T09:57:14.491641937Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-09-26T09:57:14.491650073Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-09-26T09:57:14.491658149Z    -> 0.0009s
2025-09-26T09:57:14.491666055Z == 20241105121830 AddInProgressToProblems: migrated (0.0009s) =================
2025-09-26T09:57:14.491674151Z 
2025-09-26T09:57:14.491681917Z Migrating to ClearStuckProblems (20241118155027)
2025-09-26T09:57:14.491689943Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-09-26T09:57:14.491697999Z == 20241118155027 ClearStuckProblems: migrated (0.0181s) ======================
2025-09-26T09:57:14.491706186Z 
2025-09-26T09:57:14.491723862Z Migrating to AddApprovedToUser (20241122121621)
2025-09-26T09:57:14.491732128Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-09-26T09:57:14.491740405Z -- change_table(:users)
2025-09-26T09:57:14.491748361Z    -> 0.0014s
2025-09-26T09:57:14.491756217Z == 20241122121621 AddApprovedToUser: migrated (0.0014s) =======================
2025-09-26T09:57:14.491764293Z 
2025-09-26T09:57:14.491772079Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-09-26T09:57:14.491780145Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-09-26T09:57:14.491788822Z -- create_table(:federails_moderation_reports)
2025-09-26T09:57:14.491796848Z    -> 0.0030s
2025-09-26T09:57:14.491804764Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0030s) ========
2025-09-26T09:57:14.491812891Z 
2025-09-26T09:57:14.491820847Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-09-26T09:57:14.491828933Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-09-26T09:57:14.491837350Z -- create_table(:federails_moderation_domain_blocks)
2025-09-26T09:57:14.491861489Z    -> 0.0004s
2025-09-26T09:57:14.491872421Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0005s) ===
2025-09-26T09:57:14.491880557Z 
2025-09-26T09:57:14.491888393Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-09-26T09:57:14.491896439Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-09-26T09:57:14.491904575Z -- change_column_null(:comments, :commenter_id, true)
2025-09-26T09:57:14.491912872Z    -> 0.0077s
2025-09-26T09:57:14.491921069Z -- change_column_null(:comments, :commenter_type, true)
2025-09-26T09:57:14.491929055Z    -> 0.0078s
2025-09-26T09:57:14.491937121Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-09-26T09:57:14.491945257Z    -> 0.0008s
2025-09-26T09:57:14.491953193Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-09-26T09:57:14.491961290Z    -> 0.0110s
2025-09-26T09:57:15.253199404Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0288s) =======
2025-09-26T09:57:15.253251148Z 
2025-09-26T09:57:15.253261369Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-09-26T09:57:15.253269966Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-09-26T09:57:15.253279695Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-09-26T09:57:15.253289816Z    -> 0.0009s
2025-09-26T09:57:15.253299385Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0009s) =================
2025-09-26T09:57:15.253336540Z 
2025-09-26T09:57:15.253345117Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-09-26T09:57:15.253353284Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-09-26T09:57:15.253362833Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1165s) ==================
2025-09-26T09:57:15.253373274Z 
2025-09-26T09:57:15.253382683Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-09-26T09:57:15.253390919Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-09-26T09:57:15.253399206Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-09-26T09:57:15.253407413Z    -> 0.0018s
2025-09-26T09:57:15.253415389Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0018s) ==========
2025-09-26T09:57:15.253423495Z 
2025-09-26T09:57:15.253431261Z Migrating to AddCreatorToCollections (20250222000000)
2025-09-26T09:57:15.253439357Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-09-26T09:57:15.253449788Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-09-26T09:57:15.253460079Z    -> 0.0220s
2025-09-26T09:57:15.253468225Z == 20250222000000 AddCreatorToCollections: migrated (0.0221s) =================
2025-09-26T09:57:15.253476351Z 
2025-09-26T09:57:15.253484227Z Migrating to AddLocalToActors (20250305171530)
2025-09-26T09:57:15.253492474Z == 20250305171530 AddLocalToActors: migrating =================================
2025-09-26T09:57:15.253500570Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-09-26T09:57:15.253508927Z    -> 0.0010s
2025-09-26T09:57:15.253516913Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-09-26T09:57:15.253526372Z    -> 0.0020s
2025-09-26T09:57:15.253536352Z    -> 0 rows
2025-09-26T09:57:15.253546062Z == 20250305171530 AddLocalToActors: migrated (0.0064s) ========================
2025-09-26T09:57:15.253554349Z 
2025-09-26T09:57:15.253562234Z Migrating to AddActorTypeToActors (20250407160721)
2025-09-26T09:57:15.253570862Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-09-26T09:57:15.253579389Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-09-26T09:57:15.253587505Z    -> 0.0011s
2025-09-26T09:57:15.253595461Z == 20250407160721 AddActorTypeToActors: migrated (0.0012s) ====================
2025-09-26T09:57:15.253603618Z 
2025-09-26T09:57:15.253612967Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-09-26T09:57:15.253623097Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-09-26T09:57:15.253644590Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-09-26T09:57:15.253653067Z    -> 0.0018s
2025-09-26T09:57:15.253661474Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0018s) =================
2025-09-26T09:57:15.253669591Z 
2025-09-26T09:57:15.253677366Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-09-26T09:57:15.253685372Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-09-26T09:57:15.253694811Z -- create_table(:oauth_applications)
2025-09-26T09:57:15.253705102Z    -> 0.0006s
2025-09-26T09:57:15.253714521Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-09-26T09:57:15.253722677Z    -> 0.0002s
2025-09-26T09:57:15.253730924Z -- create_table(:oauth_access_grants)
2025-09-26T09:57:15.253739121Z    -> 0.0007s
2025-09-26T09:57:15.253747037Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-09-26T09:57:15.253756105Z    -> 0.0002s
2025-09-26T09:57:15.253764872Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-09-26T09:57:15.253775153Z    -> 0.0093s
2025-09-26T09:57:15.253786456Z -- create_table(:oauth_access_tokens)
2025-09-26T09:57:15.253797017Z    -> 0.0008s
2025-09-26T09:57:15.253805364Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-09-26T09:57:15.253813731Z    -> 0.0002s
2025-09-26T09:57:15.253821787Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-09-26T09:57:15.253830214Z    -> 0.0002s
2025-09-26T09:57:15.253838421Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-09-26T09:57:15.253846908Z    -> 0.0100s
2025-09-26T09:57:15.253854804Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-09-26T09:57:15.253864393Z    -> 0.0085s
2025-09-26T09:57:15.253875044Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-09-26T09:57:15.253884553Z    -> 0.0123s
2025-09-26T09:57:15.253892509Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0432s) ==================
2025-09-26T09:57:15.253900646Z 
2025-09-26T09:57:15.253909063Z Migrating to AddOwnerToApplication (20250408145956)
2025-09-26T09:57:15.253917119Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-09-26T09:57:15.253925486Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-09-26T09:57:15.253933893Z    -> 0.0014s
2025-09-26T09:57:15.253942871Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-09-26T09:57:15.253965046Z    -> 0.0009s
2025-09-26T09:57:15.253973493Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-09-26T09:57:15.253982481Z    -> 0.0002s
2025-09-26T09:57:15.253990998Z == 20250408145956 AddOwnerToApplication: migrated (0.0077s) ===================
2025-09-26T09:57:15.253999445Z 
2025-09-26T09:57:15.254007822Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-09-26T09:57:15.254016229Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-09-26T09:57:15.254024766Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-09-26T09:57:15.254035578Z    -> 0.0108s
2025-09-26T09:57:15.254045307Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0122s) ============
2025-09-26T09:57:15.254054736Z 
2025-09-26T09:57:15.254062612Z Migrating to AddQuotaToUsers (20250409125753)
2025-09-26T09:57:15.254071259Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-09-26T09:57:15.254079736Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-09-26T09:57:15.254087843Z    -> 0.0011s
2025-09-26T09:57:15.254095869Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-09-26T09:57:15.254104035Z    -> 0.0009s
2025-09-26T09:57:15.254113144Z == 20250409125753 AddQuotaToUsers: migrated (0.0034s) =========================
2025-09-26T09:57:15.254123154Z 
2025-09-26T09:57:15.254132813Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-09-26T09:57:15.254140980Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-09-26T09:57:15.254149727Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-09-26T09:57:15.254158194Z    -> 0.0117s
2025-09-26T09:57:15.254166181Z -- add_index(:model_files, :filename_lower)
2025-09-26T09:57:15.254174187Z    -> 0.0002s
2025-09-26T09:57:15.254182063Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0133s) 
2025-09-26T09:57:15.254190179Z 
2025-09-26T09:57:15.254198997Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-09-26T09:57:15.254208977Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-09-26T09:57:15.254218596Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-09-26T09:57:15.254226773Z    -> 0.0002s
2025-09-26T09:57:15.254234829Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0012s) ===================
2025-09-26T09:57:15.254242995Z 
2025-09-26T09:57:15.254250851Z Migrating to AddPreviewToModelFile (20250520111046)
2025-09-26T09:57:15.254268777Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-09-26T09:57:15.254277595Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-09-26T09:57:15.254287675Z    -> 0.0011s
2025-09-26T09:57:15.254297505Z == 20250520111046 AddPreviewToModelFile: migrated (0.0020s) ===================
2025-09-26T09:57:15.254306443Z 
2025-09-26T09:57:15.254314329Z Migrating to CreateAltchaSolutions (20250609210440)
2025-09-26T09:57:15.254322335Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-09-26T09:57:15.254330461Z -- create_table(:altcha_solutions)
2025-09-26T09:57:15.254338467Z    -> 0.0005s
2025-09-26T09:57:15.254347075Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-09-26T09:57:15.254355672Z    -> 0.0002s
2025-09-26T09:57:15.254364370Z == 20250609210440 CreateAltchaSolutions: migrated (0.0018s) ===================
2025-09-26T09:57:15.254374380Z 
2025-09-26T09:57:15.254384560Z Migrating to AddIndexableFields (20250620141805)
2025-09-26T09:57:15.254392817Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-09-26T09:57:15.254400973Z -- change_table(:models)
2025-09-26T09:57:15.254408909Z    -> 0.0026s
2025-09-26T09:57:15.254416845Z -- change_table(:creators)
2025-09-26T09:57:15.254425072Z    -> 0.0018s
2025-09-26T09:57:15.254433058Z -- change_table(:collections)
2025-09-26T09:57:15.254440974Z    -> 0.0017s
2025-09-26T09:57:15.254450263Z == 20250620141805 AddIndexableFields: migrated (0.0061s) ======================
2025-09-26T09:57:15.254460383Z 
2025-09-26T09:57:15.254470553Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-09-26T09:57:15.254478860Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-09-26T09:57:15.254487037Z -- change_column(:models, :indexable, :string)
2025-09-26T09:57:15.254495113Z    -> 0.0373s
2025-09-26T09:57:15.254503089Z -- change_column(:models, :ai_indexable, :string)
2025-09-26T09:57:15.254511115Z    -> 0.0226s
2025-09-26T09:57:15.254519121Z -- change_column(:creators, :indexable, :string)
2025-09-26T09:57:15.254527157Z    -> 0.0103s
2025-09-26T09:57:15.254536456Z -- change_column(:creators, :ai_indexable, :string)
2025-09-26T09:57:15.254546627Z    -> 0.0103s
2025-09-26T09:57:15.254555735Z -- change_column(:collections, :indexable, :string)
2025-09-26T09:57:15.254563861Z    -> 0.0523s
2025-09-26T09:57:15.254571787Z -- change_column(:collections, :ai_indexable, :string)
2025-09-26T09:57:15.254589974Z    -> 0.0142s
2025-09-26T09:57:15.254598200Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1476s) ======
2025-09-26T09:57:15.254606517Z 
2025-09-26T09:57:15.254616467Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-09-26T09:57:15.254626918Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-09-26T09:57:15.254636999Z -- change_table(:models)
2025-09-26T09:57:15.254645406Z    -> 0.0004s
2025-09-26T09:57:15.254653622Z -- change_table(:creators)
2025-09-26T09:57:15.254661829Z    -> 0.0003s
2025-09-26T09:57:15.254670526Z -- change_table(:collections)
2025-09-26T09:57:15.254678723Z    -> 0.0003s
2025-09-26T09:57:15.254686979Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0010s) =================
2025-09-26T09:57:15.254696789Z 
2025-09-26T09:57:15.254707080Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-09-26T09:57:15.254717280Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-09-26T09:57:15.254725717Z -- change_table(:links)
2025-09-26T09:57:15.254734485Z    -> 0.0002s
2025-09-26T09:57:15.254743162Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-09-26T09:57:15.254751229Z 
2025-09-26T09:57:15.254759004Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-09-26T09:57:15.254767010Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-09-26T09:57:15.254775097Z -- add_column(:links, :synced_at, :datetime)
2025-09-26T09:57:15.254784135Z    -> 0.0011s
2025-09-26T09:57:15.254793925Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0011s) ======================
2025-09-26T09:57:15.254803644Z 
2025-09-26T09:57:15.254811941Z Migrating to CreateFaspClientProviders (20250806142734)
2025-09-26T09:57:15.254820628Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-09-26T09:57:15.254828995Z -- create_table(:fasp_client_providers)
2025-09-26T09:57:15.254836971Z    -> 0.0445s
2025-09-26T09:57:15.254845258Z == 20250806142734 CreateFaspClientProviders: migrated (0.0445s) ===============
2025-09-26T09:57:15.254853645Z 
2025-09-26T09:57:15.254861400Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-09-26T09:57:15.254871000Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-09-26T09:57:15.254881631Z -- create_table(:fasp_client_event_subscriptions)
2025-09-26T09:57:15.254890970Z    -> 0.0128s
2025-09-26T09:57:15.254899006Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0128s) ======
2025-09-26T09:57:15.254907173Z 
2025-09-26T09:57:15.254925640Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-09-26T09:57:15.285054299Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-09-26T09:57:15.285092967Z -- create_table(:fasp_client_backfill_requests)
2025-09-26T09:57:15.285102526Z    -> 0.0052s
2025-09-26T09:57:15.285111394Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0052s) ========
2025-09-26T09:57:15.285119510Z 
2025-09-26T09:57:15.285127316Z Migrating to AddImagesToCreators (20250922155445)
2025-09-26T09:57:15.285135272Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-09-26T09:57:15.285143308Z -- add_column(:creators, :avatar_data, :json)
2025-09-26T09:57:15.285151214Z    -> 0.0011s
2025-09-26T09:57:15.285159120Z -- add_column(:creators, :banner_data, :json)
2025-09-26T09:57:15.285167116Z    -> 0.0009s
2025-09-26T09:57:15.285175032Z == 20250922155445 AddImagesToCreators: migrated (0.0020s) =====================
2025-09-26T09:57:15.285183078Z 
2025-09-26T09:57:15.341096919Z s6-rc: info: service init-manyfold-config successfully started
2025-09-26T09:57:15.341373266Z s6-rc: info: service init-config-end: starting
2025-09-26T09:57:15.343131897Z s6-rc: info: service init-config-end successfully started
2025-09-26T09:57:15.343256889Z s6-rc: info: service init-mods: starting
2025-09-26T09:57:15.345500758Z s6-rc: info: service init-mods successfully started
2025-09-26T09:57:15.345638926Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-09-26T09:57:15.354518616Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-09-26T09:57:15.354655833Z s6-rc: info: service init-mods-package-install: starting
2025-09-26T09:57:15.366192584Z [pkg-install-init] **** Installing all mod packages ****
2025-09-26T09:57:15.377481065Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-09-26T09:57:15.458587255Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-09-26T09:57:15.789922712Z (1/1) Installing redis (8.0.3-r0)
2025-09-26T09:57:15.799766725Z Executing redis-8.0.3-r0.pre-install
2025-09-26T09:57:15.840911977Z Executing redis-8.0.3-r0.post-install
2025-09-26T09:57:15.849429027Z Executing busybox-1.37.0-r19.trigger
2025-09-26T09:57:15.862358142Z OK: 427 MiB in 116 packages
2025-09-26T09:57:15.951336464Z s6-rc: info: service init-mods-package-install successfully started
2025-09-26T09:57:15.951654475Z s6-rc: info: service init-mods-end: starting
2025-09-26T09:57:15.953935338Z s6-rc: info: service init-mods-end successfully started
2025-09-26T09:57:15.954301826Z s6-rc: info: service init-custom-files: starting
2025-09-26T09:57:15.960787896Z [custom-init] No custom files found, skipping...
2025-09-26T09:57:15.961294957Z s6-rc: info: service init-custom-files successfully started
2025-09-26T09:57:15.961470431Z s6-rc: info: service init-services: starting
2025-09-26T09:57:15.963251297Z s6-rc: info: service init-services successfully started
2025-09-26T09:57:15.963464706Z s6-rc: info: service svc-mod-universal-redis: starting
2025-09-26T09:57:15.963820563Z s6-rc: info: service svc-manyfold: starting
2025-09-26T09:57:15.964108282Z s6-rc: info: service svc-cron: starting
2025-09-26T09:57:15.966333493Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-09-26T09:57:15.966891627Z s6-rc: info: service svc-cron successfully started
2025-09-26T09:57:15.977403895Z 281:C 26 Sep 2025 09:57:15.977 # 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-26T09:57:15.977436801Z 281:C 26 Sep 2025 09:57:15.977 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-09-26T09:57:15.977446641Z 281:C 26 Sep 2025 09:57:15.977 * Redis version=8.0.3, bits=64, commit=00000000, modified=1, pid=281, just started
2025-09-26T09:57:15.977455339Z 281:C 26 Sep 2025 09:57:15.977 # 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-26T09:57:15.978074776Z 281:M 26 Sep 2025 09:57:15.977 * monotonic clock: POSIX clock_gettime
2025-09-26T09:57:15.978516315Z 281:M 26 Sep 2025 09:57:15.978 * Running mode=standalone, port=6379.
2025-09-26T09:57:15.978863394Z 281:M 26 Sep 2025 09:57:15.978 * Server initialized
2025-09-26T09:57:15.978879176Z 281:M 26 Sep 2025 09:57:15.978 * Ready to accept connections tcp
2025-09-26T09:57:16.134125640Z 09:57:16 rails.1              | started with pid 301
2025-09-26T09:57:16.134164558Z 09:57:16 default_worker.1     | started with pid 302
2025-09-26T09:57:16.134180971Z 09:57:16 performance_worker.1 | started with pid 303
2025-09-26T09:57:17.819419958Z 09:57:17 performance_worker.1 | `/root` is not writable.
2025-09-26T09:57:17.819452584Z 09:57:17 performance_worker.1 | Bundler will use `/tmp/bundler20250926-303-3pnddw303' as your home directory temporarily.
2025-09-26T09:57:17.829397289Z 09:57:17 default_worker.1     | `/root` is not writable.
2025-09-26T09:57:17.829421447Z 09:57:17 default_worker.1     | Bundler will use `/tmp/bundler20250926-302-ypavxc302' as your home directory temporarily.
2025-09-26T09:57:18.232282753Z 09:57:18 rails.1              | `/root` is not writable.
2025-09-26T09:57:18.241440804Z 09:57:18 rails.1              | Bundler will use `/tmp/bundler20250926-301-6ttojm301' as your home directory temporarily.
2025-09-26T09:57:19.288264590Z 09:57:19 performance_worker.1 | Server: f5aaea356990, Context: rails, Role: web, data: {cpu: {one_min: 3.5, five_min: 2.47, fifteen_min: 2.26}, memory: 0.18796544e9, disk: {available: 842897829888, total: 938656133120, used: 95758303232}}
2025-09-26T09:57:19.311595641Z 09:57:19 default_worker.1     | Server: f5aaea356990, Context: rails, Role: web, data: {cpu: {one_min: 3.5, five_min: 2.47, fifteen_min: 2.26}, memory: 0.18712576e9, disk: {available: 842894221312, total: 938656133120, used: 95761911808}}
2025-09-26T09:57:19.592105573Z 09:57:19 rails.1              | => Booting Puma
2025-09-26T09:57:19.592137968Z 09:57:19 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-09-26T09:57:19.592185193Z 09:57:19 rails.1              | => Run `bin/rails server --help` for more startup options
2025-09-26T09:57:21.620812877Z 09:57:21 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:21.622397999Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.622Z pid=302 tid=24e: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-26T09:57:21.628051293Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.627Z pid=302 tid=24e: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-09-26T09:57:21.629865496Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.629Z pid=302 tid=24e: Cron Jobs - added job with name clear-downloads in the namespace default
2025-09-26T09:57:21.680227187Z 09:57:21 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:21.681275368Z 09:57:21 performance_worker.1 | INFO  2025-09-26T09:57:21.681Z pid=303 tid=24f: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-26T09:57:21.682485385Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.682Z pid=302 tid=24e: Booted Rails 8.0.2.1 application in production environment
2025-09-26T09:57:21.682567199Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.682Z pid=302 tid=24e: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-26T09:57:21.682640537Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.682Z pid=302 tid=24e: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-26T09:57:21.682764757Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.682Z pid=302 tid=24e: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-26T09:57:21.685388901Z 09:57:21 default_worker.1     | INFO  2025-09-26T09:57:21.685Z pid=302 tid=24e: Sidekiq 8.0.7 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-09-26T09:57:21.752800024Z 09:57:21 performance_worker.1 | INFO  2025-09-26T09:57:21.752Z pid=303 tid=24f: Booted Rails 8.0.2.1 application in production environment
2025-09-26T09:57:21.752826487Z 09:57:21 performance_worker.1 | INFO  2025-09-26T09:57:21.752Z pid=303 tid=24f: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-26T09:57:21.752836748Z 09:57:21 performance_worker.1 | INFO  2025-09-26T09:57:21.752Z pid=303 tid=24f: See LICENSE and the LGPL-3.0 for licensing details.
2025-09-26T09:57:21.752866959Z 09:57:21 performance_worker.1 | INFO  2025-09-26T09:57:21.752Z pid=303 tid=24f: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-09-26T09:57:21.755749844Z 09:57:21 performance_worker.1 | INFO  2025-09-26T09:57:21.755Z pid=303 tid=24f: Sidekiq 8.0.7 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-09-26T09:57:21.864747588Z 09:57:21 rails.1              | Server: f5aaea356990, Context: rails, Role: web, data: {cpu: {one_min: 3.5, five_min: 2.47, fifteen_min: 2.26}, memory: 0.170389504e9, disk: {available: 842860744704, total: 938656133120, used: 95795388416}}
2025-09-26T09:57:21.864774883Z 09:57:21 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:21.864813401Z 09:57:21 rails.1              | INFO  2025-09-26T09:57:21.669Z pid=301 tid=20d: Sidekiq 8.0.7 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-09-26T09:57:21.864861758Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: b9dea44e-d32f-479e-897a-aa4dcc2a9e95) 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-26T09:57:21.864925086Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c) 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-26T09:57:21.864954715Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 5ba32638-dced-4c55-aed4-aeb8427fad07) 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-26T09:57:21.864995998Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: f1c390b1-34b4-48ed-8c35-b6927b9ad6c5) to Sidekiq(upgrade)
2025-09-26T09:57:21.865040698Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: 07c097bd-6f8f-464d-a209-db0e673f90a9) to Sidekiq(upgrade)
2025-09-26T09:57:21.865123094Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: 71d230ba-2c53-489a-9919-950837fca913) to Sidekiq(upgrade)
2025-09-26T09:57:21.871079088Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 9c271ce4-16c6-4d3b-86be-3c0d08292812) to Sidekiq(upgrade)
2025-09-26T09:57:21.871150021Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 3bcf5be1-2b89-4c8f-bc38-498b4d2fdc37) to Sidekiq(upgrade)
2025-09-26T09:57:21.871194490Z 09:57:21 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: 8282fa47-d44f-49de-9c08-798f8ddaac46) to Sidekiq(upgrade)
2025-09-26T09:57:21.871260063Z 09:57:21 rails.1              | [301] Puma starting in cluster mode...
2025-09-26T09:57:21.871292468Z 09:57:21 rails.1              | [301] * Puma version: 7.0.4 ("Romantic Warrior")
2025-09-26T09:57:21.871336777Z 09:57:21 rails.1              | [301] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-09-26T09:57:21.871407519Z 09:57:21 rails.1              | [301] *  Min threads: 4
2025-09-26T09:57:21.871443412Z 09:57:21 rails.1              | [301] *  Max threads: 16
2025-09-26T09:57:21.871483553Z 09:57:21 rails.1              | [301] *  Environment: production
2025-09-26T09:57:21.871533513Z 09:57:21 rails.1              | [301] *   Master PID: 301
2025-09-26T09:57:21.871573454Z 09:57:21 rails.1              | [301] *      Workers: 4
2025-09-26T09:57:21.871621350Z 09:57:21 rails.1              | [301] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-09-26T09:57:21.871671862Z 09:57:21 rails.1              | [301] * Preloading application
2025-09-26T09:57:21.871721832Z 09:57:21 rails.1              | [301] * Listening on http://[::]:3214
2025-09-26T09:57:21.871762484Z 09:57:21 rails.1              | [301] Use Ctrl-C to stop
2025-09-26T09:57:21.888499547Z 09:57:21 rails.1              | [301] - Worker 0 (PID: 377) booted in 0.02s, phase: 0
2025-09-26T09:57:21.888659038Z 09:57:21 rails.1              | [301] - Worker 1 (PID: 389) booted in 0.01s, phase: 0
2025-09-26T09:57:21.888746644Z 09:57:21 rails.1              | [301] - Worker 2 (PID: 403) booted in 0.01s, phase: 0
2025-09-26T09:57:21.890756331Z 09:57:21 rails.1              | [301] - Worker 3 (PID: 416) booted in 0.0s, phase: 0
2025-09-26T09:57:21.970134452Z 09:57:21 default_worker.1     | Server: f5aaea356990, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.5, five_min: 2.47, fifteen_min: 2.26}, memory: 0.237776896e9, disk: {available: 842854678528, total: 938656133120, used: 95801454592}}
2025-09-26T09:57:22.002924981Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-09-26T09:57:22.004171561Z s6-rc: info: service svc-manyfold successfully started
2025-09-26T09:57:22.004454591Z s6-rc: info: service legacy-services: starting
2025-09-26T09:57:22.010949048Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.010Z pid=302 tid=h3q jid=133f425635946cbb01eba330 class=Upgrade::GenerateSlugsJob: start
2025-09-26T09:57:22.016274852Z s6-rc: info: service legacy-services successfully started
2025-09-26T09:57:22.016541710Z s6-rc: info: service ci-service-check: starting
2025-09-26T09:57:22.021254530Z [ls.io-init] done.
2025-09-26T09:57:22.022336969Z 09:57:22 performance_worker.1 | Server: f5aaea356990, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.5, five_min: 2.47, fifteen_min: 2.26}, memory: 0.240734208e9, disk: {available: 842854674432, total: 938656133120, used: 95801458688}}
2025-09-26T09:57:22.022105624Z s6-rc: info: service ci-service-check successfully started
2025-09-26T09:57:22.038287449Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [b9dea44e-d32f-479e-897a-aa4dcc2a9e95] Performing Upgrade::GenerateSlugsJob (Job ID: b9dea44e-d32f-479e-897a-aa4dcc2a9e95) from Sidekiq(high) enqueued at 2025-09-26T09:57:21.687553440Z 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-26T09:57:22.044041635Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.010Z pid=302 tid=h66 jid=566c06b123c972a16ebdcf7a class=Upgrade::GenerateSlugsJob: start
2025-09-26T09:57:22.057646761Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c] Performing Upgrade::GenerateSlugsJob (Job ID: d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c) from Sidekiq(high) enqueued at 2025-09-26T09:57:21.691799991Z 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-26T09:57:22.060476439Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.030Z pid=302 tid=h5y jid=f1d0cda4507230969de08d7c class=Upgrade::GenerateSlugsJob: start
2025-09-26T09:57:22.100747872Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [5ba32638-dced-4c55-aed4-aeb8427fad07] Performing Upgrade::GenerateSlugsJob (Job ID: 5ba32638-dced-4c55-aed4-aeb8427fad07) from Sidekiq(high) enqueued at 2025-09-26T09:57:21.694992940Z 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-26T09:57:22.102236370Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.030Z pid=302 tid=h6m jid=6e50ef4d147ce03a6bdc839d class=Upgrade::FixNilFileSizeValues: start
2025-09-26T09:57:22.103445384Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f1c390b1-34b4-48ed-8c35-b6927b9ad6c5] Performing Upgrade::FixNilFileSizeValues (Job ID: f1c390b1-34b4-48ed-8c35-b6927b9ad6c5) from Sidekiq(upgrade) enqueued at 2025-09-26T09:57:21.698426605Z
2025-09-26T09:57:22.113861479Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f1c390b1-34b4-48ed-8c35-b6927b9ad6c5] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.115894292Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.154607678Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [5ba32638-dced-4c55-aed4-aeb8427fad07] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.351079966Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f1c390b1-34b4-48ed-8c35-b6927b9ad6c5] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-26T09:57:22.374440185Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f1c390b1-34b4-48ed-8c35-b6927b9ad6c5] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.219
2025-09-26T09:57:22.390336876Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-26T09:57:22.410077386Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.142
2025-09-26T09:57:22.417047732Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [5ba32638-dced-4c55-aed4-aeb8427fad07] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-26T09:57:22.418205053Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [5ba32638-dced-4c55-aed4-aeb8427fad07] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.043
2025-09-26T09:57:22.423407288Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [b9dea44e-d32f-479e-897a-aa4dcc2a9e95] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.518583731Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [b9dea44e-d32f-479e-897a-aa4dcc2a9e95] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-26T09:57:22.518614102Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [b9dea44e-d32f-479e-897a-aa4dcc2a9e95] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.056
2025-09-26T09:57:22.528780815Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [f1c390b1-34b4-48ed-8c35-b6927b9ad6c5] Performed Upgrade::FixNilFileSizeValues (Job ID: f1c390b1-34b4-48ed-8c35-b6927b9ad6c5) from Sidekiq(upgrade) in 425.25ms
2025-09-26T09:57:22.529429681Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c] Performed Upgrade::GenerateSlugsJob (Job ID: d1f2c356-af1d-4e85-ab14-ac6ab67d2b1c) from Sidekiq(high) in 483.37ms
2025-09-26T09:57:22.530598695Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [5ba32638-dced-4c55-aed4-aeb8427fad07] Performed Upgrade::GenerateSlugsJob (Job ID: 5ba32638-dced-4c55-aed4-aeb8427fad07) from Sidekiq(high) in 449.29ms
2025-09-26T09:57:22.531000534Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.529Z pid=302 tid=h6m jid=6e50ef4d147ce03a6bdc839d class=Upgrade::FixNilFileSizeValues elapsed=0.499: done
2025-09-26T09:57:22.531553107Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.531Z pid=302 tid=h5y jid=f1d0cda4507230969de08d7c class=Upgrade::GenerateSlugsJob elapsed=0.501: done
2025-09-26T09:57:22.531883763Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [b9dea44e-d32f-479e-897a-aa4dcc2a9e95] Performed Upgrade::GenerateSlugsJob (Job ID: b9dea44e-d32f-479e-897a-aa4dcc2a9e95) from Sidekiq(high) in 499.15ms
2025-09-26T09:57:22.532278558Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.530Z pid=302 tid=h66 jid=566c06b123c972a16ebdcf7a class=Upgrade::GenerateSlugsJob elapsed=0.52: done
2025-09-26T09:57:22.538834700Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.531Z pid=302 tid=h6m jid=8f79ad823f04dcc434febfe7 class=Upgrade::BackfillDataPackages: start
2025-09-26T09:57:22.543726460Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [07c097bd-6f8f-464d-a209-db0e673f90a9] Performing Upgrade::BackfillDataPackages (Job ID: 07c097bd-6f8f-464d-a209-db0e673f90a9) from Sidekiq(upgrade) enqueued at 2025-09-26T09:57:21.699440837Z
2025-09-26T09:57:22.544219533Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.532Z pid=302 tid=h5y jid=f59175bd71796985cee19e12 class=Upgrade::DisambiguateUsernamesJob: start
2025-09-26T09:57:22.547677086Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [71d230ba-2c53-489a-9919-950837fca913] Performing Upgrade::DisambiguateUsernamesJob (Job ID: 71d230ba-2c53-489a-9919-950837fca913) from Sidekiq(upgrade) enqueued at 2025-09-26T09:57:21.700322272Z
2025-09-26T09:57:22.548816249Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.538Z pid=302 tid=h3q jid=133f425635946cbb01eba330 class=Upgrade::GenerateSlugsJob elapsed=0.528: done
2025-09-26T09:57:22.549314904Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.543Z pid=302 tid=h66 jid=72b841828d1c1672856d80f8 class=Upgrade::UpdateActorsJob: start
2025-09-26T09:57:22.554433951Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [07c097bd-6f8f-464d-a209-db0e673f90a9] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.616878653Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.553Z pid=302 tid=h3q jid=206ee44358a344dff32f788b class=Upgrade::FixParentCollections: start
2025-09-26T09:57:22.673688940Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [9c271ce4-16c6-4d3b-86be-3c0d08292812] Performing Upgrade::UpdateActorsJob (Job ID: 9c271ce4-16c6-4d3b-86be-3c0d08292812) from Sidekiq(upgrade) enqueued at 2025-09-26T09:57:21.701181141Z
2025-09-26T09:57:22.677893527Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [71d230ba-2c53-489a-9919-950837fca913] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.799604661Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [3bcf5be1-2b89-4c8f-bc38-498b4d2fdc37] Performing Upgrade::FixParentCollections (Job ID: 3bcf5be1-2b89-4c8f-bc38-498b4d2fdc37) from Sidekiq(upgrade) enqueued at 2025-09-26T09:57:21.702122627Z
2025-09-26T09:57:22.806048227Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [9c271ce4-16c6-4d3b-86be-3c0d08292812] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.885226986Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [3bcf5be1-2b89-4c8f-bc38-498b4d2fdc37] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:22.898307405Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [07c097bd-6f8f-464d-a209-db0e673f90a9] Performed Upgrade::BackfillDataPackages (Job ID: 07c097bd-6f8f-464d-a209-db0e673f90a9) from Sidekiq(upgrade) in 354.51ms
2025-09-26T09:57:22.938086476Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.937Z pid=302 tid=h6m jid=8f79ad823f04dcc434febfe7 class=Upgrade::BackfillDataPackages elapsed=0.405: done
2025-09-26T09:57:22.943276738Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [71d230ba-2c53-489a-9919-950837fca913] Performed Upgrade::DisambiguateUsernamesJob (Job ID: 71d230ba-2c53-489a-9919-950837fca913) from Sidekiq(upgrade) in 395.59ms
2025-09-26T09:57:22.951887838Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [9c271ce4-16c6-4d3b-86be-3c0d08292812] Performed Upgrade::UpdateActorsJob (Job ID: 9c271ce4-16c6-4d3b-86be-3c0d08292812) from Sidekiq(upgrade) in 397.39ms
2025-09-26T09:57:22.952352554Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.943Z pid=302 tid=h6m jid=68871d78afd592f12269785e class=Upgrade::PruneOrphanedProblems: start
2025-09-26T09:57:22.958009324Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.957Z pid=302 tid=h66 jid=72b841828d1c1672856d80f8 class=Upgrade::UpdateActorsJob elapsed=0.414: done
2025-09-26T09:57:22.958043864Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [3bcf5be1-2b89-4c8f-bc38-498b4d2fdc37] Performed Upgrade::FixParentCollections (Job ID: 3bcf5be1-2b89-4c8f-bc38-498b4d2fdc37) from Sidekiq(upgrade) in 278.92ms
2025-09-26T09:57:22.958126851Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.951Z pid=302 tid=h5y jid=f59175bd71796985cee19e12 class=Upgrade::DisambiguateUsernamesJob elapsed=0.419: done
2025-09-26T09:57:22.958186611Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [8282fa47-d44f-49de-9c08-798f8ddaac46] Performing Upgrade::PruneOrphanedProblems (Job ID: 8282fa47-d44f-49de-9c08-798f8ddaac46) from Sidekiq(upgrade) enqueued at 2025-09-26T09:57:21.703155036Z
2025-09-26T09:57:22.958514452Z 09:57:22 default_worker.1     | INFO  2025-09-26T09:57:22.958Z pid=302 tid=h3q jid=206ee44358a344dff32f788b class=Upgrade::FixParentCollections elapsed=0.405: done
2025-09-26T09:57:22.961324751Z 09:57:22 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [8282fa47-d44f-49de-9c08-798f8ddaac46] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-09-26T09:57:23.134770230Z 09:57:23 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [8282fa47-d44f-49de-9c08-798f8ddaac46] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-09-26T09:57:23.135399407Z 09:57:23 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [8282fa47-d44f-49de-9c08-798f8ddaac46] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.102
2025-09-26T09:57:23.154235838Z 09:57:23 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [8282fa47-d44f-49de-9c08-798f8ddaac46] Performed Upgrade::PruneOrphanedProblems (Job ID: 8282fa47-d44f-49de-9c08-798f8ddaac46) from Sidekiq(upgrade) in 199.98ms
2025-09-26T09:57:23.155615215Z 09:57:23 default_worker.1     | INFO  2025-09-26T09:57:23.154Z pid=302 tid=h6m jid=68871d78afd592f12269785e class=Upgrade::PruneOrphanedProblems elapsed=0.211: done
2025-09-26T09:57:52.512660584Z 09:57:52 rails.1              | [897fded1-6ca8-4b02-b171-f982b3893965] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1394,"duration":23.25,"view":0.0,"db":2.28,"@timestamp":"2025-09-26T09:57:52.511Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-26T09:57:53.521862719Z 09:57:53 rails.1              | [0708d46f-44dc-41a2-b826-d79122e2bdd4] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":73804,"duration":986.9,"view":0.0,"db":29.93,"location":"http://172.17.0.4:3214/","@timestamp":"2025-09-26T09:57:53.521Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-26T09:57:53.610693593Z 09:57:53 rails.1              | [30c34d77-9e42-48fd-806d-ab51d10fdff0] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1056,"duration":56.48,"view":0.0,"db":3.48,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-09-26T09:57:53.590Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-26T09:57:54.442995613Z 09:57:54 rails.1              | [148b39f3-e5c2-4d48-9642-44ceacb0b7ef] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24007,"duration":794.13,"view":632.1,"db":70.49,"@timestamp":"2025-09-26T09:57:54.441Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-09-26T09:57:54.519148738Z 09:57:54 rails.1              | [86c0fd18-61a1-4fe6-a7f8-7b964dbebc92] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1181,"duration":28.6,"view":0.0,"db":2.64,"@timestamp":"2025-09-26T09:57:54.517Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-09-26T09:57:54.862869994Z 09:57:54 rails.1              | [806d167f-64c4-495d-b685-489a8b99e12c] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":14490,"duration":209.88,"view":0.0,"db":1.29,"location":"http://172.17.0.4:3214/","@timestamp":"2025-09-26T09:57:54.820Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-09-26T09:57:54.923116160Z 09:57:54 rails.1              | [37597513-e380-4fb9-b697-b99210b4fa1b] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1144,"duration":51.45,"view":0.0,"db":4.38,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-09-26T09:57:54.922Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-09-26T09:57:55.305257189Z 09:57:55 rails.1              | [e29f87a4-2f07-4f0c-876d-9bcc58d3920c] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":24259,"duration":353.92,"view":205.95,"db":1.13,"@timestamp":"2025-09-26T09:57:55.300Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}