2025-11-19T09:03:37.403002843Z /package/admin/s6-overlay/libexec/preinit: info: container permissions: uid=0 (root), euid=0, gid=0 (root), egid=0
2025-11-19T09:03:37.403024847Z /package/admin/s6-overlay/libexec/preinit: info: /run permissions: uid=0 (root), gid=0 (root), perms=oxorgxgruxuwur
2025-11-19T09:03:37.448041334Z [mod-init] Running Docker Modification Logic
2025-11-19T09:03:37.686062295Z [mod-init] Adding linuxserver/mods:universal-redis to container
2025-11-19T09:03:38.413453474Z [mod-init] Downloading linuxserver/mods:universal-redis from lscr.io
2025-11-19T09:03:38.972514638Z [mod-init] Installing linuxserver/mods:universal-redis
2025-11-19T09:03:38.996029583Z [mod-init] linuxserver/mods:universal-redis applied to container
2025-11-19T09:03:38.996990918Z /run/s6/basedir/scripts/rc.init: info: hook /docker-mods exited 0
2025-11-19T09:03:39.018525225Z s6-rc: info: service s6rc-oneshot-runner: starting
2025-11-19T09:03:39.021913317Z s6-rc: info: service s6rc-oneshot-runner successfully started
2025-11-19T09:03:39.022067748Z s6-rc: info: service fix-attrs: starting
2025-11-19T09:03:39.022265786Z s6-rc: info: service init-migrations: starting
2025-11-19T09:03:39.022356499Z s6-rc: info: service init-envfile: starting
2025-11-19T09:03:39.027303660Z [migrations] started
2025-11-19T09:03:39.027345825Z [migrations] no migrations found
2025-11-19T09:03:39.028006936Z s6-rc: info: service init-migrations successfully started
2025-11-19T09:03:39.028247180Z s6-rc: info: service init-adduser: starting
2025-11-19T09:03:39.029608140Z s6-rc: info: service fix-attrs successfully started
2025-11-19T09:03:39.029767771Z s6-rc: info: service legacy-cont-init: starting
2025-11-19T09:03:39.031445920Z s6-rc: info: service init-envfile successfully started
2025-11-19T09:03:39.037004461Z s6-rc: info: service legacy-cont-init successfully started
2025-11-19T09:03:39.055162651Z usermod: no changes
2025-11-19T09:03:39.061043191Z ───────────────────────────────────────
2025-11-19T09:03:39.061076949Z 
2025-11-19T09:03:39.061086498Z       ██╗     ███████╗██╗ ██████╗
2025-11-19T09:03:39.061095276Z       ██║     ██╔════╝██║██╔═══██╗
2025-11-19T09:03:39.061103994Z       ██║     ███████╗██║██║   ██║
2025-11-19T09:03:39.061112371Z       ██║     ╚════██║██║██║   ██║
2025-11-19T09:03:39.061120687Z       ███████╗███████║██║╚██████╔╝
2025-11-19T09:03:39.061129255Z       ╚══════╝╚══════╝╚═╝ ╚═════╝
2025-11-19T09:03:39.061137912Z 
2025-11-19T09:03:39.061145888Z    Brought to you by linuxserver.io
2025-11-19T09:03:39.061171019Z ───────────────────────────────────────
2025-11-19T09:03:39.061372695Z 
2025-11-19T09:03:39.061383847Z To support LSIO projects visit:
2025-11-19T09:03:39.061392094Z https://www.linuxserver.io/donate/
2025-11-19T09:03:39.061400090Z 
2025-11-19T09:03:39.061408096Z ───────────────────────────────────────
2025-11-19T09:03:39.061416673Z GID/UID
2025-11-19T09:03:39.061424940Z ───────────────────────────────────────
2025-11-19T09:03:39.065977145Z 
2025-11-19T09:03:39.065993528Z User UID:    911
2025-11-19T09:03:39.065997917Z User GID:    911
2025-11-19T09:03:39.066001765Z ───────────────────────────────────────
2025-11-19T09:03:39.067774724Z Linuxserver.io version: v0.129.2-ls118
2025-11-19T09:03:39.068073426Z Build-date: 2025-11-19T08:54:21+00:00
2025-11-19T09:03:39.068096602Z ───────────────────────────────────────
2025-11-19T09:03:39.068107023Z     
2025-11-19T09:03:39.086122987Z s6-rc: info: service init-adduser successfully started
2025-11-19T09:03:39.086254862Z s6-rc: info: service init-device-perms: starting
2025-11-19T09:03:39.091309810Z s6-rc: info: service init-device-perms successfully started
2025-11-19T09:03:39.091429771Z s6-rc: info: service init-os-end: starting
2025-11-19T09:03:39.092595759Z s6-rc: info: service init-os-end successfully started
2025-11-19T09:03:39.092741182Z s6-rc: info: service init-manyfold-config: starting
2025-11-19T09:03:39.092912897Z s6-rc: info: service init-config: starting
2025-11-19T09:03:39.094651288Z s6-rc: info: service init-config successfully started
2025-11-19T09:03:39.094844026Z s6-rc: info: service init-crontab-config: starting
2025-11-19T09:03:39.097484051Z **** SECRET_KEY_BASE set in environment. ****
2025-11-19T09:03:39.104000882Z s6-rc: info: service init-crontab-config successfully started
2025-11-19T09:03:39.122746324Z **** Running Manyfold database init. ****
2025-11-19T09:03:48.289277972Z Server: 02f5c4735d80, Context: rails, Role: web, data: {cpu: {one_min: 3.2, five_min: 2.24, fifteen_min: 2.05}, memory: 0.213499904e9, disk: {available: 839940587520, total: 938656133120, used: 98715545600}}
2025-11-19T09:03:48.289327091Z Monitor error: Connection refused - connect(2) for 127.0.0.1:6379 (redis://localhost:6379)
2025-11-19T09:03:48.289337632Z INFO  2025-11-19T09:03:46.407Z pid=173 tid=2h9: Sidekiq 8.0.9 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-11-19T09:03:48.289347171Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.default_viewer_role` fallback to returns the default value.
2025-11-19T09:03:48.289389166Z WARNING: table: "settings" does not exist or not database connection, `SiteSettings.anonymous_usage_id` fallback to returns the default value.
2025-11-19T09:03:48.289397813Z Migrating to CreateLibraries (20210130201037)
2025-11-19T09:03:48.289405980Z == 20210130201037 CreateLibraries: migrating ==================================
2025-11-19T09:03:48.289414577Z -- create_table(:libraries)
2025-11-19T09:03:48.289422603Z    -> 0.0027s
2025-11-19T09:03:48.289430750Z == 20210130201037 CreateLibraries: migrated (0.0027s) =========================
2025-11-19T09:03:48.289438956Z 
2025-11-19T09:03:48.289446812Z Migrating to CreateModels (20210130203243)
2025-11-19T09:03:48.289454778Z == 20210130203243 CreateModels: migrating =====================================
2025-11-19T09:03:48.289462804Z -- create_table(:models)
2025-11-19T09:03:48.289470700Z    -> 0.0008s
2025-11-19T09:03:48.289478676Z == 20210130203243 CreateModels: migrated (0.0009s) ============================
2025-11-19T09:03:48.289486692Z 
2025-11-19T09:03:48.289494859Z Migrating to CreateParts (20210205230918)
2025-11-19T09:03:48.289502735Z == 20210205230918 CreateParts: migrating ======================================
2025-11-19T09:03:48.289510821Z -- create_table(:parts)
2025-11-19T09:03:48.289518687Z    -> 0.0033s
2025-11-19T09:03:48.289526763Z == 20210205230918 CreateParts: migrated (0.0033s) =============================
2025-11-19T09:03:48.289535110Z 
2025-11-19T09:03:48.289543116Z Migrating to AddFieldsToParts (20210210153744)
2025-11-19T09:03:48.289551212Z == 20210210153744 AddFieldsToParts: migrating =================================
2025-11-19T09:03:48.289559308Z -- add_column(:parts, :presupported, :boolean, {default: false, null: false})
2025-11-19T09:03:48.289567405Z    -> 0.0007s
2025-11-19T09:03:48.289575661Z -- add_column(:parts, :printed, :boolean, {default: false, null: false})
2025-11-19T09:03:48.289583688Z    -> 0.0003s
2025-11-19T09:03:48.289591533Z == 20210210153744 AddFieldsToParts: migrated (0.0011s) ========================
2025-11-19T09:03:48.289599529Z 
2025-11-19T09:03:48.289607405Z Migrating to ActsAsTaggableOnMigration (20210212143001)
2025-11-19T09:03:48.289615712Z == 20210212143001 ActsAsTaggableOnMigration: migrating ========================
2025-11-19T09:03:48.289623949Z -- create_table(:tags, {id: :integer})
2025-11-19T09:03:48.289631865Z    -> 0.0038s
2025-11-19T09:03:48.289641644Z -- create_table(:taggings, {id: :integer})
2025-11-19T09:03:48.289649941Z    -> 0.0017s
2025-11-19T09:03:48.289657947Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-11-19T09:03:48.289676104Z    -> 0.0002s
2025-11-19T09:03:48.289684220Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-11-19T09:03:48.289692577Z    -> 0.0020s
2025-11-19T09:03:48.289700603Z == 20210212143001 ActsAsTaggableOnMigration: migrated (0.0078s) ===============
2025-11-19T09:03:48.289708739Z 
2025-11-19T09:03:48.289716625Z Migrating to AddMissingUniqueIndices (20210212143002)
2025-11-19T09:03:48.289724721Z == 20210212143002 AddMissingUniqueIndices: migrating ==========================
2025-11-19T09:03:48.289733199Z -- add_index(:tags, :name, {unique: true, name: "index_tags_on_name"})
2025-11-19T09:03:48.289741355Z    -> 0.0003s
2025-11-19T09:03:48.289749201Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-11-19T09:03:48.289757347Z    -> 0.0004s
2025-11-19T09:03:48.289765143Z -- remove_foreign_key(:taggings, :tags)
2025-11-19T09:03:48.289773059Z    -> 0.1622s
2025-11-19T09:03:48.289780844Z -- remove_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-11-19T09:03:48.289788951Z    -> 0.0146s
2025-11-19T09:03:48.289796747Z -- remove_index(:taggings, nil, {name: "taggings_taggable_context_idx"})
2025-11-19T09:03:48.289804863Z    -> 0.0002s
2025-11-19T09:03:48.289813109Z -- add_index(:taggings, [:tag_id, :taggable_id, :taggable_type, :context, :tagger_id, :tagger_type], {unique: true, name: "taggings_idx"})
2025-11-19T09:03:48.289821546Z    -> 0.0049s
2025-11-19T09:03:48.289829372Z -- add_foreign_key(:taggings, :tags, {column: "tag_id"})
2025-11-19T09:03:48.289837468Z    -> 0.0671s
2025-11-19T09:03:48.289845264Z == 20210212143002 AddMissingUniqueIndices: migrated (0.2800s) =================
2025-11-19T09:03:48.289853511Z 
2025-11-19T09:03:48.289861387Z Migrating to AddTaggingsCounterCacheToTags (20210212143003)
2025-11-19T09:03:48.289869553Z == 20210212143003 AddTaggingsCounterCacheToTags: migrating ====================
2025-11-19T09:03:48.289877780Z -- add_column(:tags, :taggings_count, :integer, {default: 0})
2025-11-19T09:03:48.289886146Z    -> 0.0357s
2025-11-19T09:03:48.289894153Z == 20210212143003 AddTaggingsCounterCacheToTags: migrated (0.1191s) ===========
2025-11-19T09:03:48.289902479Z 
2025-11-19T09:03:48.289910315Z Migrating to AddMissingTaggableIndex (20210212143004)
2025-11-19T09:03:48.289918241Z == 20210212143004 AddMissingTaggableIndex: migrating ==========================
2025-11-19T09:03:48.289926428Z -- add_index(:taggings, [:taggable_id, :taggable_type, :context], {name: "taggings_taggable_context_idx"})
2025-11-19T09:03:48.289934875Z    -> 0.0002s
2025-11-19T09:03:48.289942901Z == 20210212143004 AddMissingTaggableIndex: migrated (0.0003s) =================
2025-11-19T09:03:48.289960486Z 
2025-11-19T09:03:48.289968422Z Migrating to ChangeCollationForTagNames (20210212143005)
2025-11-19T09:03:48.289976448Z == 20210212143005 ChangeCollationForTagNames: migrating =======================
2025-11-19T09:03:48.289984495Z == 20210212143005 ChangeCollationForTagNames: migrated (0.0008s) ==============
2025-11-19T09:03:48.289992571Z 
2025-11-19T09:03:48.290000757Z Migrating to AddMissingIndexesOnTaggings (20210212143006)
2025-11-19T09:03:48.290008813Z == 20210212143006 AddMissingIndexesOnTaggings: migrating ======================
2025-11-19T09:03:48.290016950Z -- index_exists?(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-11-19T09:03:48.290025126Z    -> 0.0076s
2025-11-19T09:03:48.290032952Z -- add_index(:taggings, :tag_id, {name: "index_taggings_on_tag_id"})
2025-11-19T09:03:48.290041058Z    -> 0.0002s
2025-11-19T09:03:48.290048904Z -- index_exists?(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-11-19T09:03:48.290057071Z    -> 0.0058s
2025-11-19T09:03:48.290064886Z -- add_index(:taggings, :taggable_id, {name: "index_taggings_on_taggable_id"})
2025-11-19T09:03:48.290073043Z    -> 0.0012s
2025-11-19T09:03:48.290080889Z -- index_exists?(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-11-19T09:03:48.290089125Z    -> 0.0004s
2025-11-19T09:03:48.290096901Z -- add_index(:taggings, :taggable_type, {name: "index_taggings_on_taggable_type"})
2025-11-19T09:03:48.290105057Z    -> 0.0001s
2025-11-19T09:03:48.290112873Z -- index_exists?(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-11-19T09:03:48.290121200Z    -> 0.0039s
2025-11-19T09:03:48.290129857Z -- add_index(:taggings, :tagger_id, {name: "index_taggings_on_tagger_id"})
2025-11-19T09:03:48.290138164Z    -> 0.0001s
2025-11-19T09:03:48.290146220Z -- index_exists?(:taggings, :context, {name: "index_taggings_on_context"})
2025-11-19T09:03:48.290154527Z    -> 0.0005s
2025-11-19T09:03:48.290162353Z -- add_index(:taggings, :context, {name: "index_taggings_on_context"})
2025-11-19T09:03:48.290170449Z    -> 0.0001s
2025-11-19T09:03:48.290178295Z -- index_exists?(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-11-19T09:03:48.290186672Z    -> 0.0006s
2025-11-19T09:03:48.290194688Z -- add_index(:taggings, [:tagger_id, :tagger_type], {name: "index_taggings_on_tagger_id_and_tagger_type"})
2025-11-19T09:03:48.290203175Z    -> 0.0001s
2025-11-19T09:03:48.290211572Z -- index_exists?(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-11-19T09:03:48.290219868Z    -> 0.0014s
2025-11-19T09:03:48.290240640Z -- add_index(:taggings, [:taggable_id, :taggable_type, :tagger_id, :context], {name: "taggings_idy"})
2025-11-19T09:03:48.290249097Z    -> 0.0001s
2025-11-19T09:03:48.290256993Z == 20210212143006 AddMissingIndexesOnTaggings: migrated (0.0227s) =============
2025-11-19T09:03:48.290265009Z 
2025-11-19T09:03:48.290272735Z Migrating to AddPreviewPartToModel (20210220204055)
2025-11-19T09:03:48.290280691Z == 20210220204055 AddPreviewPartToModel: migrating ============================
2025-11-19T09:03:48.290288867Z -- add_reference(:models, :preview_part, {null: true, foreign_key: {to_table: :parts}})
2025-11-19T09:03:48.290296964Z    -> 0.2310s
2025-11-19T09:03:48.290304870Z == 20210220204055 AddPreviewPartToModel: migrated (0.2310s) ===================
2025-11-19T09:03:48.290312956Z 
2025-11-19T09:03:48.290320721Z Migrating to CreateCreators (20210225232756)
2025-11-19T09:03:48.290328677Z == 20210225232756 CreateCreators: migrating ===================================
2025-11-19T09:03:48.290337265Z -- create_table(:creators)
2025-11-19T09:03:48.290345251Z    -> 0.0143s
2025-11-19T09:03:48.290353237Z == 20210225232756 CreateCreators: migrated (0.0143s) ==========================
2025-11-19T09:03:48.290361313Z 
2025-11-19T09:03:48.290369139Z Migrating to AddCreatorToModels (20210225232841)
2025-11-19T09:03:48.290377035Z == 20210225232841 AddCreatorToModels: migrating ===============================
2025-11-19T09:03:48.290385051Z -- add_reference(:models, :creator, {null: true, foreign_key: true})
2025-11-19T09:03:48.290393057Z    -> 0.0507s
2025-11-19T09:03:48.290400853Z == 20210225232841 AddCreatorToModels: migrated (0.0508s) ======================
2025-11-19T09:03:48.290408879Z 
2025-11-19T09:03:48.290416635Z Migrating to CreateLinks (20210301230017)
2025-11-19T09:03:48.290424530Z == 20210301230017 CreateLinks: migrating ======================================
2025-11-19T09:03:48.290432567Z -- create_table(:links)
2025-11-19T09:03:48.290440493Z    -> 0.0007s
2025-11-19T09:03:48.290448529Z == 20210301230017 CreateLinks: migrated (0.0007s) =============================
2025-11-19T09:03:48.290456775Z 
2025-11-19T09:03:48.290464631Z Migrating to DropLinkFieldsFromCreators (20210302161202)
2025-11-19T09:03:48.290472758Z == 20210302161202 DropLinkFieldsFromCreators: migrating =======================
2025-11-19T09:03:48.290481024Z -- remove_column(:creators, :thingiverse_user, :string)
2025-11-19T09:03:48.290489201Z    -> 0.0767s
2025-11-19T09:03:48.290497217Z -- remove_column(:creators, :cults3d_user, :string)
2025-11-19T09:03:48.290505564Z    -> 0.0143s
2025-11-19T09:03:48.290513580Z -- remove_column(:creators, :mmf_user, :string)
2025-11-19T09:03:48.290530965Z    -> 0.0231s
2025-11-19T09:03:48.290538901Z -- remove_column(:creators, :cgtrader_user, :string)
2025-11-19T09:03:48.290546857Z    -> 0.0088s
2025-11-19T09:03:48.290554943Z == 20210302161202 DropLinkFieldsFromCreators: migrated (0.1253s) ==============
2025-11-19T09:03:48.290562939Z 
2025-11-19T09:03:48.290570645Z Migrating to RemoveFkConstraintFromModelPreviewPart (20210314185822)
2025-11-19T09:03:48.290578621Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrating ===========
2025-11-19T09:03:48.290586607Z -- remove_foreign_key(:models, :parts, {column: :preview_part_id})
2025-11-19T09:03:48.290594533Z    -> 0.0675s
2025-11-19T09:03:48.290602338Z == 20210314185822 RemoveFkConstraintFromModelPreviewPart: migrated (0.0676s) ==
2025-11-19T09:03:48.290610595Z 
2025-11-19T09:03:48.290618351Z Migrating to AddYUpToParts (20210318202638)
2025-11-19T09:03:48.290626267Z == 20210318202638 AddYUpToParts: migrating ====================================
2025-11-19T09:03:48.290634233Z -- add_column(:parts, :y_up, :boolean, {default: false, null: false})
2025-11-19T09:03:48.290642209Z    -> 0.0162s
2025-11-19T09:03:48.290650085Z == 20210318202638 AddYUpToParts: migrated (0.0163s) ===========================
2025-11-19T09:03:48.290658041Z 
2025-11-19T09:03:48.290665756Z Migrating to CreateImages (20210321164508)
2025-11-19T09:03:48.290673652Z == 20210321164508 CreateImages: migrating =====================================
2025-11-19T09:03:48.290681708Z -- create_table(:images)
2025-11-19T09:03:48.290689574Z    -> 0.0167s
2025-11-19T09:03:48.290697400Z == 20210321164508 CreateImages: migrated (0.0167s) ============================
2025-11-19T09:03:48.290705526Z 
2025-11-19T09:03:48.290713242Z Migrating to CreateDelayedJobs (20210330215825)
2025-11-19T09:03:48.973132133Z == 20210330215825 CreateDelayedJobs: migrating ================================
2025-11-19T09:03:48.973173326Z -- create_table(:delayed_jobs)
2025-11-19T09:03:48.973183146Z    -> 0.0111s
2025-11-19T09:03:48.973191874Z -- add_index(:delayed_jobs, [:priority, :run_at], {name: "delayed_jobs_priority"})
2025-11-19T09:03:48.973200511Z    -> 0.0002s
2025-11-19T09:03:48.973208687Z == 20210330215825 CreateDelayedJobs: migrated (0.0113s) =======================
2025-11-19T09:03:48.973216854Z 
2025-11-19T09:03:48.973224990Z Migrating to RenamePartsToModelFiles (20220105233138)
2025-11-19T09:03:48.973233137Z == 20220105233138 RenamePartsToModelFiles: migrating ==========================
2025-11-19T09:03:48.973241333Z -- rename_table(:parts, :model_files)
2025-11-19T09:03:48.973249409Z    -> 0.0017s
2025-11-19T09:03:48.973257476Z -- rename_column(:models, :preview_part_id, :preview_file_id)
2025-11-19T09:03:48.973298148Z    -> 0.0451s
2025-11-19T09:03:48.973306364Z == 20220105233138 RenamePartsToModelFiles: migrated (0.0473s) =================
2025-11-19T09:03:48.973314531Z 
2025-11-19T09:03:48.973322366Z Migrating to RemoveImagesTable (20220106220519)
2025-11-19T09:03:48.973330372Z == 20220106220519 RemoveImagesTable: migrating ================================
2025-11-19T09:03:48.973338499Z -- drop_table(:images)
2025-11-19T09:03:48.973346515Z    -> 0.0003s
2025-11-19T09:03:48.973354501Z == 20220106220519 RemoveImagesTable: migrated (0.0003s) =======================
2025-11-19T09:03:48.973362617Z 
2025-11-19T09:03:48.973370443Z Migrating to AddServiceNameToActiveStorageBlobs (20220612220115)
2025-11-19T09:03:48.973378850Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrating ===============
2025-11-19T09:03:48.973387016Z -- table_exists?(:active_storage_blobs)
2025-11-19T09:03:48.973395113Z    -> 0.0001s
2025-11-19T09:03:48.973403059Z == 20220612220115 AddServiceNameToActiveStorageBlobs: migrated (0.0002s) ======
2025-11-19T09:03:48.973411396Z 
2025-11-19T09:03:48.973419241Z Migrating to CreateActiveStorageVariantRecords (20220612220116)
2025-11-19T09:03:48.973427278Z == 20220612220116 CreateActiveStorageVariantRecords: migrating ================
2025-11-19T09:03:48.973435394Z -- table_exists?(:active_storage_blobs)
2025-11-19T09:03:48.973443350Z    -> 0.0001s
2025-11-19T09:03:48.973451346Z == 20220612220116 CreateActiveStorageVariantRecords: migrated (0.0001s) =======
2025-11-19T09:03:48.973459422Z 
2025-11-19T09:03:48.973467208Z Migrating to RemoveNotNullOnActiveStorageBlobsChecksum (20220612220117)
2025-11-19T09:03:48.973475324Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrating ========
2025-11-19T09:03:48.973483411Z -- table_exists?(:active_storage_blobs)
2025-11-19T09:03:48.973491357Z    -> 0.0001s
2025-11-19T09:03:48.973499293Z == 20220612220117 RemoveNotNullOnActiveStorageBlobsChecksum: migrated (0.0001s) 
2025-11-19T09:03:48.973507439Z 
2025-11-19T09:03:48.973515245Z Migrating to DeviseCreateUsers (20220614210023)
2025-11-19T09:03:48.973523211Z == 20220614210023 DeviseCreateUsers: migrating ================================
2025-11-19T09:03:48.973531327Z -- create_table(:users)
2025-11-19T09:03:48.973539303Z    -> 0.0011s
2025-11-19T09:03:48.973547239Z -- add_index(:users, :email, {unique: true, name: "index_users_on_email"})
2025-11-19T09:03:48.973555526Z    -> 0.0015s
2025-11-19T09:03:48.973563442Z == 20220614210023 DeviseCreateUsers: migrated (0.0028s) =======================
2025-11-19T09:03:48.973571538Z 
2025-11-19T09:03:48.973599705Z Migrating to AddUsernameToUsers (20220614211256)
2025-11-19T09:03:48.973609595Z == 20220614211256 AddUsernameToUsers: migrating ===============================
2025-11-19T09:03:48.973618062Z -- add_column(:users, :username, :string, {null: false})
2025-11-19T09:03:48.973626268Z    -> 0.0276s
2025-11-19T09:03:48.973634364Z -- add_index(:users, :username, {unique: true, name: "index_users_on_username"})
2025-11-19T09:03:48.973642681Z    -> 0.0001s
2025-11-19T09:03:48.973650717Z == 20220614211256 AddUsernameToUsers: migrated (0.0278s) ======================
2025-11-19T09:03:48.973658854Z 
2025-11-19T09:03:48.973666649Z Migrating to AddAdminToUsers (20220614213902)
2025-11-19T09:03:48.973674676Z == 20220614213902 AddAdminToUsers: migrating ==================================
2025-11-19T09:03:48.973682742Z -- add_column(:users, :admin, :boolean, {default: false, null: false})
2025-11-19T09:03:48.973690948Z    -> 0.0005s
2025-11-19T09:03:48.973698864Z == 20220614213902 AddAdminToUsers: migrated (0.0005s) =========================
2025-11-19T09:03:48.973706961Z 
2025-11-19T09:03:48.973714736Z Migrating to AddPaginationSettingsToUser (20220617122809)
2025-11-19T09:03:48.973722762Z == 20220617122809 AddPaginationSettingsToUser: migrating ======================
2025-11-19T09:03:48.973730809Z -- add_column(:users, :pagination_settings, :json, {default: {"per_page" => 12}})
2025-11-19T09:03:48.973739296Z    -> 0.0011s
2025-11-19T09:03:48.973747262Z == 20220617122809 AddPaginationSettingsToUser: migrated (0.0011s) =============
2025-11-19T09:03:48.973755408Z 
2025-11-19T09:03:48.973763174Z Migrating to CreateSettings (20220619174307)
2025-11-19T09:03:48.973771160Z == 20220619174307 CreateSettings: migrating ===================================
2025-11-19T09:03:48.973779266Z -- create_table(:settings)
2025-11-19T09:03:48.973787202Z    -> 0.0027s
2025-11-19T09:03:48.973795138Z -- add_index(:settings, [:var], {unique: true, name: "index_settings_on_var"})
2025-11-19T09:03:48.973803365Z    -> 0.0002s
2025-11-19T09:03:48.973811311Z == 20220619174307 CreateSettings: migrated (0.0029s) ==========================
2025-11-19T09:03:48.973819437Z 
2025-11-19T09:03:48.973827213Z Migrating to AddScaleFactorToModels (20220626152444)
2025-11-19T09:03:48.973835229Z == 20220626152444 AddScaleFactorToModels: migrating ===========================
2025-11-19T09:03:48.973843295Z -- add_column(:models, :scale_factor, :decimal, {null: false, default: 100.0})
2025-11-19T09:03:48.973851371Z    -> 0.0101s
2025-11-19T09:03:48.973859277Z == 20220626152444 AddScaleFactorToModels: migrated (0.0124s) ==================
2025-11-19T09:03:48.973867384Z 
2025-11-19T09:03:48.973875149Z Migrating to AddDigestToModelFiles (20220702202932)
2025-11-19T09:03:48.973892795Z == 20220702202932 AddDigestToModelFiles: migrating ============================
2025-11-19T09:03:48.973900991Z -- add_column(:model_files, :digest, :string)
2025-11-19T09:03:48.973909088Z    -> 0.0023s
2025-11-19T09:03:48.973917004Z -- add_index(:model_files, :digest, {name: "index_model_files_on_digest"})
2025-11-19T09:03:48.973925200Z    -> 0.0002s
2025-11-19T09:03:48.973933156Z == 20220702202932 AddDigestToModelFiles: migrated (0.0044s) ===================
2025-11-19T09:03:48.973941192Z 
2025-11-19T09:03:48.973948958Z Migrating to AddRendererSettingsToUsers (20221128165903)
2025-11-19T09:03:48.973957505Z == 20221128165903 AddRendererSettingsToUsers: migrating =======================
2025-11-19T09:03:48.973965782Z -- 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-11-19T09:03:48.974001804Z    -> 0.0008s
2025-11-19T09:03:48.974009840Z == 20221128165903 AddRendererSettingsToUsers: migrated (0.0011s) ==============
2025-11-19T09:03:48.974017997Z 
2025-11-19T09:03:48.974025813Z Migrating to CreateProblems (20221210001132)
2025-11-19T09:03:48.974033829Z == 20221210001132 CreateProblems: migrating ===================================
2025-11-19T09:03:48.974041935Z -- create_table(:problems)
2025-11-19T09:03:48.974049961Z    -> 0.0008s
2025-11-19T09:03:48.974057887Z == 20221210001132 CreateProblems: migrated (0.0011s) ==========================
2025-11-19T09:03:48.974066004Z 
2025-11-19T09:03:48.974073849Z Migrating to AddNewDefaultsToRendererSettings (20221214230757)
2025-11-19T09:03:48.974081916Z == 20221214230757 AddNewDefaultsToRendererSettings: migrating =================
2025-11-19T09:03:48.974090002Z == 20221214230757 AddNewDefaultsToRendererSettings: migrated (0.0158s) ========
2025-11-19T09:03:48.974098088Z 
2025-11-19T09:03:48.974105904Z Migrating to ActsAsFavoritorMigration (20221219204414)
2025-11-19T09:03:48.974113970Z == 20221219204414 ActsAsFavoritorMigration: migrating =========================
2025-11-19T09:03:48.974122086Z -- create_table(:favorites, {force: true})
2025-11-19T09:03:48.974130093Z    -> 0.0041s
2025-11-19T09:03:48.974138019Z -- add_index(:favorites, ["favoritor_id", "favoritor_type"], {name: "fk_favorites"})
2025-11-19T09:03:48.974146596Z    -> 0.0002s
2025-11-19T09:03:48.974154542Z -- add_index(:favorites, ["favoritable_id", "favoritable_type"], {name: "fk_favoritables"})
2025-11-19T09:03:48.974163059Z    -> 0.0002s
2025-11-19T09:03:48.974171105Z -- add_index(:favorites, ["favoritable_type", "favoritable_id", "favoritor_type", "favoritor_id", "scope"], {name: "uniq_favorites__and_favoritables", unique: true})
2025-11-19T09:03:48.974189312Z    -> 0.0002s
2025-11-19T09:03:48.974197288Z == 20221219204414 ActsAsFavoritorMigration: migrated (0.0053s) ================
2025-11-19T09:03:48.974205424Z 
2025-11-19T09:03:48.974213190Z Migrating to MovePrintedToFavorites (20221220223040)
2025-11-19T09:03:48.974221246Z == 20221220223040 MovePrintedToFavorites: migrating ===========================
2025-11-19T09:03:48.974229322Z == 20221220223040 MovePrintedToFavorites: migrated (0.0566s) ==================
2025-11-19T09:03:48.974237379Z 
2025-11-19T09:03:48.974245154Z Migrating to DropPrintedFromModelFiles (20221220223340)
2025-11-19T09:03:48.974253180Z == 20221220223340 DropPrintedFromModelFiles: migrating ========================
2025-11-19T09:03:48.974261247Z -- remove_column(:model_files, :printed, :boolean)
2025-11-19T09:03:48.974269223Z    -> 0.0267s
2025-11-19T09:03:48.974277139Z == 20221220223340 DropPrintedFromModelFiles: migrated (0.0271s) ===============
2025-11-19T09:03:48.974285185Z 
2025-11-19T09:03:48.974293512Z Migrating to AddNotesExcerptToModels (20230202210000)
2025-11-19T09:03:48.974301618Z == 20230202210000 AddNotesExcerptToModels: migrating ==========================
2025-11-19T09:03:48.974309734Z -- add_column(:models, :notes, :text)
2025-11-19T09:03:48.974317740Z    -> 0.0012s
2025-11-19T09:03:48.974325686Z -- add_column(:models, :excerpt, :text)
2025-11-19T09:03:48.974333642Z    -> 0.0021s
2025-11-19T09:03:48.974341528Z == 20230202210000 AddNotesExcerptToModels: migrated (0.0033s) =================
2025-11-19T09:03:48.974349605Z 
2025-11-19T09:03:48.974357420Z Migrating to AddNotesExcerptToCreators (20230202210001)
2025-11-19T09:03:48.974365416Z == 20230202210001 AddNotesExcerptToCreators: migrating ========================
2025-11-19T09:03:48.974373513Z -- add_column(:creators, :notes, :text)
2025-11-19T09:03:48.974381529Z    -> 0.0005s
2025-11-19T09:03:48.974389445Z -- add_column(:creators, :excerpt, :text)
2025-11-19T09:03:48.974397391Z    -> 0.0004s
2025-11-19T09:03:48.974405287Z == 20230202210001 AddNotesExcerptToCreators: migrated (0.0010s) ===============
2025-11-19T09:03:48.974413383Z 
2025-11-19T09:03:48.974421139Z Migrating to AddNotesExcerptToModelFiles (20230203150000)
2025-11-19T09:03:48.974429125Z == 20230203150000 AddNotesExcerptToModelFiles: migrating ======================
2025-11-19T09:03:48.974437211Z -- add_column(:model_files, :notes, :text)
2025-11-19T09:03:48.974445217Z    -> 0.0005s
2025-11-19T09:03:48.974453153Z -- add_column(:model_files, :excerpt, :text)
2025-11-19T09:03:48.974461159Z    -> 0.0005s
2025-11-19T09:03:48.974480187Z == 20230203150000 AddNotesExcerptToModelFiles: migrated (0.0010s) =============
2025-11-19T09:03:48.974488484Z 
2025-11-19T09:03:48.974496310Z Migrating to MoveScaleFactorIntoNote (20230221174212)
2025-11-19T09:03:48.974504546Z == 20230221174212 MoveScaleFactorIntoNote: migrating ==========================
2025-11-19T09:03:48.974512653Z == 20230221174212 MoveScaleFactorIntoNote: migrated (0.0187s) =================
2025-11-19T09:03:48.974520849Z 
2025-11-19T09:03:48.974528695Z Migrating to RemoveScaleFactorFromModels (20230221180921)
2025-11-19T09:03:48.974536761Z == 20230221180921 RemoveScaleFactorFromModels: migrating ======================
2025-11-19T09:03:48.974544868Z -- remove_column(:models, :scale_factor, :decimal, {default: "100.0", null: false})
2025-11-19T09:03:48.974553154Z    -> 0.0397s
2025-11-19T09:03:48.974561090Z == 20230221180921 RemoveScaleFactorFromModels: migrated (0.0397s) =============
2025-11-19T09:03:48.974569227Z 
2025-11-19T09:03:48.974577213Z Migrating to RenameExcerptToCaption (20230222155910)
2025-11-19T09:03:48.974585379Z == 20230222155910 RenameExcerptToCaption: migrating ===========================
2025-11-19T09:03:48.974593506Z -- rename_column(:creators, :excerpt, :caption)
2025-11-19T09:03:48.974601512Z    -> 0.0201s
2025-11-19T09:03:48.974609478Z -- rename_column(:models, :excerpt, :caption)
2025-11-19T09:03:48.974617504Z    -> 0.0198s
2025-11-19T09:03:48.974625460Z -- rename_column(:model_files, :excerpt, :caption)
2025-11-19T09:03:48.974633486Z    -> 0.0184s
2025-11-19T09:03:48.974641412Z == 20230222155910 RenameExcerptToCaption: migrated (0.0604s) ==================
2025-11-19T09:03:48.974649568Z 
2025-11-19T09:03:48.974657374Z Migrating to AddNotesNameCaptionToLibrary (20230303150029)
2025-11-19T09:03:48.974665410Z == 20230303150029 AddNotesNameCaptionToLibrary: migrating =====================
2025-11-19T09:03:48.974673557Z -- add_column(:libraries, :notes, :string)
2025-11-19T09:03:49.431021557Z    -> 0.0020s
2025-11-19T09:03:49.431061227Z -- add_column(:libraries, :caption, :string)
2025-11-19T09:03:49.431070576Z    -> 0.0005s
2025-11-19T09:03:49.431079213Z -- add_column(:libraries, :name, :string)
2025-11-19T09:03:49.431087580Z    -> 0.0005s
2025-11-19T09:03:49.431095717Z == 20230303150029 AddNotesNameCaptionToLibrary: migrated (0.0110s) ============
2025-11-19T09:03:49.431104414Z 
2025-11-19T09:03:49.431112370Z Migrating to AddTagregexToLibrary (20230305180823)
2025-11-19T09:03:49.431120526Z == 20230305180823 AddTagregexToLibrary: migrating =============================
2025-11-19T09:03:49.431128723Z -- add_column(:libraries, :tag_regex, :text)
2025-11-19T09:03:49.431168724Z    -> 0.0018s
2025-11-19T09:03:49.431177000Z == 20230305180823 AddTagregexToLibrary: migrated (0.0033s) ====================
2025-11-19T09:03:49.431185237Z 
2025-11-19T09:03:49.431193063Z Migrating to AddIconToLibrary (20230307215826)
2025-11-19T09:03:49.431201149Z == 20230307215826 AddIconToLibrary: migrating =================================
2025-11-19T09:03:49.431209255Z -- add_column(:libraries, :icon, :text)
2025-11-19T09:03:49.431217291Z    -> 0.0019s
2025-11-19T09:03:49.431225277Z == 20230307215826 AddIconToLibrary: migrated (0.0038s) ========================
2025-11-19T09:03:49.431233424Z 
2025-11-19T09:03:49.431241270Z Migrating to CreateCollection (20230308004237)
2025-11-19T09:03:49.431249326Z == 20230308004237 CreateCollection: migrating =================================
2025-11-19T09:03:49.431257462Z -- create_table(:collections)
2025-11-19T09:03:49.431265458Z    -> 0.0028s
2025-11-19T09:03:49.431273424Z == 20230308004237 CreateCollection: migrated (0.0070s) ========================
2025-11-19T09:03:49.431281551Z 
2025-11-19T09:03:49.431289326Z Migrating to AddCollectionToModels (20230308005021)
2025-11-19T09:03:49.431297332Z == 20230308005021 AddCollectionToModels: migrating ============================
2025-11-19T09:03:49.431305479Z -- add_reference(:models, :collection, {null: true, foreign_key: true})
2025-11-19T09:03:49.431313575Z    -> 0.0467s
2025-11-19T09:03:49.431321511Z == 20230308005021 AddCollectionToModels: migrated (0.0503s) ===================
2025-11-19T09:03:49.431329607Z 
2025-11-19T09:03:49.431337393Z Migrating to MoveCollectionTagIntoObject (20230308006000)
2025-11-19T09:03:49.431345399Z == 20230308006000 MoveCollectionTagIntoObject: migrating ======================
2025-11-19T09:03:49.431353616Z == 20230308006000 MoveCollectionTagIntoObject: migrated (0.0027s) =============
2025-11-19T09:03:49.431361732Z 
2025-11-19T09:03:49.431369578Z Migrating to RenameCollectionExcerptToCaption (20230313000000)
2025-11-19T09:03:49.431377664Z == 20230313000000 RenameCollectionExcerptToCaption: migrating =================
2025-11-19T09:03:49.431385740Z -- rename_column(:collections, :excerpt, :caption)
2025-11-19T09:03:49.431393797Z    -> 0.0048s
2025-11-19T09:03:49.431401773Z == 20230313000000 RenameCollectionExcerptToCaption: migrated (0.0048s) ========
2025-11-19T09:03:49.431409899Z 
2025-11-19T09:03:49.431417675Z Migrating to ChangePaginationSettingsOnUser (20230313000001)
2025-11-19T09:03:49.431425701Z == 20230313000001 ChangePaginationSettingsOnUser: migrating ===================
2025-11-19T09:03:49.431433847Z == 20230313000001 ChangePaginationSettingsOnUser: migrated (0.0000s) ==========
2025-11-19T09:03:49.431441994Z 
2025-11-19T09:03:49.431460942Z Migrating to AddTagCloudSettingsToUser (20230316184012)
2025-11-19T09:03:49.431469259Z == 20230316184012 AddTagCloudSettingsToUser: migrating ========================
2025-11-19T09:03:49.431477435Z -- add_column(:users, :tag_cloud_settings, :json, {default: {"threshold" => 2, "heatmap" => true, "keypair" => true, "sorting" => "frequency"}})
2025-11-19T09:03:49.431487105Z    -> 0.0017s
2025-11-19T09:03:49.431495321Z == 20230316184012 AddTagCloudSettingsToUser: migrated (0.0017s) ===============
2025-11-19T09:03:49.431503558Z 
2025-11-19T09:03:49.431511524Z Migrating to AddCollectionToCollections (20230324000000)
2025-11-19T09:03:49.431523287Z == 20230324000000 AddCollectionToCollections: migrating =======================
2025-11-19T09:03:49.431531484Z -- add_reference(:collections, :collection, {null: true, foreign_key: true})
2025-11-19T09:03:49.431539650Z    -> 0.0067s
2025-11-19T09:03:49.431547616Z == 20230324000000 AddCollectionToCollections: migrated (0.0087s) ==============
2025-11-19T09:03:49.431555733Z 
2025-11-19T09:03:49.431563518Z Migrating to RemoveDestinationExistsProblems (20230612080306)
2025-11-19T09:03:49.431571565Z == 20230612080306 RemoveDestinationExistsProblems: migrating ==================
2025-11-19T09:03:49.431579711Z == 20230612080306 RemoveDestinationExistsProblems: migrated (0.0451s) =========
2025-11-19T09:03:49.431587827Z 
2025-11-19T09:03:49.431595763Z Migrating to RemoveLeadingSeparatorsFromModelFilenames (20230613134254)
2025-11-19T09:03:49.431603930Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrating ========
2025-11-19T09:03:49.431612056Z == 20230613134254 RemoveLeadingSeparatorsFromModelFilenames: migrated (0.0070s) 
2025-11-19T09:03:49.431620263Z 
2025-11-19T09:03:49.431628048Z Migrating to AddSlugs (20230615135601)
2025-11-19T09:03:49.431635984Z == 20230615135601 AddSlugs: migrating =========================================
2025-11-19T09:03:49.431644371Z -- add_column(:models, :slug, :string)
2025-11-19T09:03:49.431652447Z    -> 0.0027s
2025-11-19T09:03:49.431660393Z -- add_index(:models, :slug, {name: "index_models_on_slug"})
2025-11-19T09:03:49.431668710Z    -> 0.0019s
2025-11-19T09:03:49.431676666Z -- add_column(:collections, :slug, :string)
2025-11-19T09:03:49.431684722Z    -> 0.0005s
2025-11-19T09:03:49.431692608Z -- add_index(:collections, :slug, {name: "index_collections_on_slug"})
2025-11-19T09:03:49.431700935Z    -> 0.0001s
2025-11-19T09:03:49.431708901Z -- add_column(:creators, :slug, :string)
2025-11-19T09:03:49.431716987Z    -> 0.0007s
2025-11-19T09:03:49.431724933Z -- add_index(:creators, :slug, {name: "index_creators_on_slug"})
2025-11-19T09:03:49.431733140Z    -> 0.0001s
2025-11-19T09:03:49.431750595Z == 20230615135601 AddSlugs: migrated (0.0065s) ================================
2025-11-19T09:03:49.431758812Z 
2025-11-19T09:03:49.431766587Z Migrating to GenerateSlugs (20230617222353)
2025-11-19T09:03:49.431774553Z == 20230617222353 GenerateSlugs: migrating ====================================
2025-11-19T09:03:49.431782720Z == 20230617222353 GenerateSlugs: migrated (0.0000s) ===========================
2025-11-19T09:03:49.431790796Z 
2025-11-19T09:03:49.431798602Z Migrating to MakeNamesUnique (20230628194944)
2025-11-19T09:03:49.431806608Z == 20230628194944 MakeNamesUnique: migrating ==================================
2025-11-19T09:03:49.431815115Z == 20230628194944 MakeNamesUnique: migrated (0.0030s) =========================
2025-11-19T09:03:49.431823312Z 
2025-11-19T09:03:49.431831959Z Migrating to AddUniqueConstraintToNamesAndSlugs (20230628195018)
2025-11-19T09:03:49.431840165Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrating ===============
2025-11-19T09:03:49.431864023Z -- add_index(:creators, :name, {unique: true, name: "index_creators_on_name"})
2025-11-19T09:03:49.431875857Z    -> 0.0020s
2025-11-19T09:03:49.431883843Z -- remove_index(:creators, :slug)
2025-11-19T09:03:49.431891799Z    -> 0.0004s
2025-11-19T09:03:49.431899735Z -- add_index(:creators, :slug, {unique: true, name: "index_creators_on_slug"})
2025-11-19T09:03:49.431907932Z    -> 0.0001s
2025-11-19T09:03:49.431915838Z -- add_index(:collections, :name, {unique: true, name: "index_collections_on_name"})
2025-11-19T09:03:49.431924405Z    -> 0.0001s
2025-11-19T09:03:49.431932361Z -- remove_index(:collections, :slug)
2025-11-19T09:03:49.431940327Z    -> 0.0228s
2025-11-19T09:03:49.431948223Z -- add_index(:collections, :slug, {unique: true, name: "index_collections_on_slug"})
2025-11-19T09:03:49.431956440Z    -> 0.0006s
2025-11-19T09:03:49.431964305Z == 20230628195018 AddUniqueConstraintToNamesAndSlugs: migrated (0.0266s) ======
2025-11-19T09:03:49.431972392Z 
2025-11-19T09:03:49.431980117Z Migrating to AddSizeToModelFiles (20230707082403)
2025-11-19T09:03:49.431988254Z == 20230707082403 AddSizeToModelFiles: migrating ==============================
2025-11-19T09:03:49.431996360Z -- add_column(:model_files, :size, :integer)
2025-11-19T09:03:49.432004326Z    -> 0.0006s
2025-11-19T09:03:49.432012202Z == 20230707082403 AddSizeToModelFiles: migrated (0.0009s) =====================
2025-11-19T09:03:49.432020278Z 
2025-11-19T09:03:49.432028034Z Migrating to ChangeFileSizeToBigInt (20230710102250)
2025-11-19T09:03:49.432036010Z == 20230710102250 ChangeFileSizeToBigInt: migrating ===========================
2025-11-19T09:03:49.432044076Z -- change_column(:model_files, :size, :bigint)
2025-11-19T09:03:49.432061461Z    -> 0.0080s
2025-11-19T09:03:49.432069537Z == 20230710102250 ChangeFileSizeToBigInt: migrated (0.0083s) ==================
2025-11-19T09:03:49.432077614Z 
2025-11-19T09:03:49.432085449Z Migrating to AddNoteToProblems (20230711111009)
2025-11-19T09:03:49.432093425Z == 20230711111009 AddNoteToProblems: migrating ================================
2025-11-19T09:03:49.432101532Z -- add_column(:problems, :note, :string, {default: nil})
2025-11-19T09:03:49.432109548Z    -> 0.0011s
2025-11-19T09:03:49.432117484Z == 20230711111009 AddNoteToProblems: migrated (0.0021s) =======================
2025-11-19T09:03:49.432125580Z 
2025-11-19T09:03:49.432133446Z Migrating to AddProblemSettingsToUser (20240122114207)
2025-11-19T09:03:49.432141452Z == 20240122114207 AddProblemSettingsToUser: migrating =========================
2025-11-19T09:03:49.432151091Z -- 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-11-19T09:03:49.432164659Z    -> 0.0006s
2025-11-19T09:03:49.432172655Z == 20240122114207 AddProblemSettingsToUser: migrated (0.0007s) ================
2025-11-19T09:03:49.432180932Z 
2025-11-19T09:03:49.432188697Z Migrating to AddLicenseToModel (20240127143358)
2025-11-19T09:03:49.432196693Z == 20240127143358 AddLicenseToModel: migrating ================================
2025-11-19T09:03:49.432204850Z -- add_column(:models, :license, :string)
2025-11-19T09:03:49.432212856Z    -> 0.0005s
2025-11-19T09:03:49.432220822Z == 20240127143358 AddLicenseToModel: migrated (0.0006s) =======================
2025-11-19T09:03:49.432228918Z 
2025-11-19T09:03:49.432236704Z Migrating to AddIgnoredToProblems (20240131134832)
2025-11-19T09:03:49.432244770Z == 20240131134832 AddIgnoredToProblems: migrating =============================
2025-11-19T09:03:49.432252846Z -- add_column(:problems, :ignored, :boolean, {default: false, null: false})
2025-11-19T09:03:49.432260973Z    -> 0.0006s
2025-11-19T09:03:49.432268919Z == 20240131134832 AddIgnoredToProblems: migrated (0.0006s) ====================
2025-11-19T09:03:49.432277035Z 
2025-11-19T09:03:49.432284811Z Migrating to AddPresupportedVersionToModelFiles (20240208143319)
2025-11-19T09:03:49.432292867Z == 20240208143319 AddPresupportedVersionToModelFiles: migrating ===============
2025-11-19T09:03:49.432300933Z -- add_reference(:model_files, :presupported_version, {foreign_key: {to_table: :model_files}})
2025-11-19T09:03:49.432318599Z    -> 0.0095s
2025-11-19T09:03:49.432326665Z == 20240208143319 AddPresupportedVersionToModelFiles: migrated (0.0095s) ======
2025-11-19T09:03:49.432334801Z 
2025-11-19T09:03:49.432342657Z Migrating to AddFileListSettingsToUser (20240209125409)
2025-11-19T09:03:49.432350663Z == 20240209125409 AddFileListSettingsToUser: migrating ========================
2025-11-19T09:03:49.432358830Z -- add_column(:users, :file_list_settings, :json, {default: {"hide_presupported_versions" => true}})
2025-11-19T09:03:49.432367327Z    -> 0.0006s
2025-11-19T09:03:49.432375253Z == 20240209125409 AddFileListSettingsToUser: migrated (0.0006s) ===============
2025-11-19T09:03:49.432383329Z 
2025-11-19T09:03:49.432391155Z Migrating to AddMissingUniqueIndexes (20240228130246)
2025-11-19T09:03:49.432399161Z == 20240228130246 AddMissingUniqueIndexes: migrating ==========================
2025-11-19T09:03:49.432407257Z -- add_index(:libraries, :path, {unique: true, name: "index_libraries_on_path"})
2025-11-19T09:03:49.432415494Z    -> 0.0002s
2025-11-19T09:03:49.432423500Z -- add_index(:models, [:path, :library_id], {unique: true, name: "index_models_on_path_and_library_id"})
2025-11-19T09:03:49.432431887Z    -> 0.0009s
2025-11-19T09:03:49.432439833Z -- add_index(:model_files, [:filename, :model_id], {unique: true, name: "index_model_files_on_filename_and_model_id"})
2025-11-19T09:03:49.432448210Z    -> 0.0001s
2025-11-19T09:03:49.951865464Z -- add_index(:problems, [:category, :problematic_id, :problematic_type], {unique: true, name: "index_problems_on_category_and_problematic_id_and_type"})
2025-11-19T09:03:49.951909072Z    -> 0.0042s
2025-11-19T09:03:49.951918922Z == 20240228130246 AddMissingUniqueIndexes: migrated (0.0055s) =================
2025-11-19T09:03:49.951927289Z 
2025-11-19T09:03:49.951935214Z Migrating to CreateFlipperTables (20240306095646)
2025-11-19T09:03:49.951943862Z == 20240306095646 CreateFlipperTables: migrating ==============================
2025-11-19T09:03:49.951952249Z -- create_table(:flipper_features)
2025-11-19T09:03:49.951960295Z    -> 0.0026s
2025-11-19T09:03:49.951968481Z -- add_index(:flipper_features, :key, {unique: true, name: "index_flipper_features_on_key"})
2025-11-19T09:03:49.951977289Z    -> 0.0044s
2025-11-19T09:03:49.951985506Z -- create_table(:flipper_gates)
2025-11-19T09:03:49.951993622Z    -> 0.0003s
2025-11-19T09:03:49.952001678Z -- 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-11-19T09:03:49.952010276Z    -> 0.0001s
2025-11-19T09:03:49.952018192Z == 20240306095646 CreateFlipperTables: migrated (0.0075s) =====================
2025-11-19T09:03:49.952060627Z 
2025-11-19T09:03:49.952068683Z Migrating to RolifyCreateRoles (20240319155251)
2025-11-19T09:03:49.952076820Z == 20240319155251 RolifyCreateRoles: migrating ================================
2025-11-19T09:03:49.952084986Z -- create_table(:roles)
2025-11-19T09:03:49.952092882Z    -> 0.0365s
2025-11-19T09:03:49.952100788Z -- create_table(:users_roles, {id: false})
2025-11-19T09:03:49.952108934Z    -> 0.0005s
2025-11-19T09:03:49.952116830Z -- add_index(:roles, :name, {name: "index_roles_on_name"})
2025-11-19T09:03:49.952124987Z    -> 0.0058s
2025-11-19T09:03:49.952132933Z -- add_index(:roles, [:name, :resource_type, :resource_id], {name: "index_roles_on_name_and_resource_type_and_resource_id"})
2025-11-19T09:03:49.952141460Z    -> 0.0002s
2025-11-19T09:03:49.952149406Z -- add_index(:users_roles, [:user_id, :role_id], {name: "index_users_roles_on_user_id_and_role_id"})
2025-11-19T09:03:49.952157702Z    -> 0.0001s
2025-11-19T09:03:49.952165578Z == 20240319155251 RolifyCreateRoles: migrated (0.0595s) =======================
2025-11-19T09:03:49.952173584Z 
2025-11-19T09:03:49.952181350Z Migrating to ConvertAdminFlagToRole (20240319155526)
2025-11-19T09:03:49.952189366Z == 20240319155526 ConvertAdminFlagToRole: migrating ===========================
2025-11-19T09:03:49.952197372Z == 20240319155526 ConvertAdminFlagToRole: migrated (0.0040s) ==================
2025-11-19T09:03:49.952205489Z 
2025-11-19T09:03:49.952213224Z Migrating to RemoveAdminFromUsers (20240319155903)
2025-11-19T09:03:49.952221160Z == 20240319155903 RemoveAdminFromUsers: migrating =============================
2025-11-19T09:03:49.952229196Z -- remove_column(:users, :admin, :boolean, {default: false, null: false})
2025-11-19T09:03:49.952241100Z    -> 0.0227s
2025-11-19T09:03:49.952249066Z == 20240319155903 RemoveAdminFromUsers: migrated (0.0240s) ====================
2025-11-19T09:03:49.952257062Z 
2025-11-19T09:03:49.952264768Z Migrating to AddResetPasswordTokenToUsers (20240322143621)
2025-11-19T09:03:49.952272884Z == 20240322143621 AddResetPasswordTokenToUsers: migrating =====================
2025-11-19T09:03:49.952280890Z -- add_column(:users, :reset_password_token, :string)
2025-11-19T09:03:49.952288937Z    -> 0.0011s
2025-11-19T09:03:49.952298426Z -- add_index(:users, :reset_password_token, {unique: true, name: "index_users_on_reset_password_token"})
2025-11-19T09:03:49.952306863Z    -> 0.0002s
2025-11-19T09:03:49.952314779Z == 20240322143621 AddResetPasswordTokenToUsers: migrated (0.0031s) ============
2025-11-19T09:03:49.952322855Z 
2025-11-19T09:03:49.952330611Z Migrating to SetAdminPasswordResetToken (20240322150022)
2025-11-19T09:03:49.952338697Z == 20240322150022 SetAdminPasswordResetToken: migrating =======================
2025-11-19T09:03:49.952356573Z == 20240322150022 SetAdminPasswordResetToken: migrated (0.0235s) ==============
2025-11-19T09:03:49.952364669Z 
2025-11-19T09:03:49.952372405Z Migrating to AddRememberableToUsers (20240410221112)
2025-11-19T09:03:49.952380371Z == 20240410221112 AddRememberableToUsers: migrating ===========================
2025-11-19T09:03:49.952388377Z -- add_column(:users, :remember_created_at, :datetime)
2025-11-19T09:03:49.952396313Z    -> 0.0031s
2025-11-19T09:03:49.952404199Z == 20240410221112 AddRememberableToUsers: migrated (0.0043s) ==================
2025-11-19T09:03:49.952412275Z 
2025-11-19T09:03:49.952419970Z Migrating to AddResetPasswordSentAtToUsers (20240410222922)
2025-11-19T09:03:49.952428117Z == 20240410222922 AddResetPasswordSentAtToUsers: migrating ====================
2025-11-19T09:03:49.952436323Z -- add_column(:users, :reset_password_sent_at, :datetime)
2025-11-19T09:03:49.952444500Z    -> 0.0007s
2025-11-19T09:03:49.952452476Z == 20240410222922 AddResetPasswordSentAtToUsers: migrated (0.0018s) ===========
2025-11-19T09:03:49.952460542Z 
2025-11-19T09:03:49.952468268Z Migrating to DropDelayedJobs (20240418112821)
2025-11-19T09:03:49.952476244Z == 20240418112821 DropDelayedJobs: migrating ==================================
2025-11-19T09:03:49.952484330Z -- drop_table(:delayed_jobs)
2025-11-19T09:03:49.952492276Z    -> 0.0022s
2025-11-19T09:03:49.952500182Z == 20240418112821 DropDelayedJobs: migrated (0.0120s) =========================
2025-11-19T09:03:49.952508439Z 
2025-11-19T09:03:49.952516345Z Migrating to AddInterfaceLanguageToUsers (20240423102250)
2025-11-19T09:03:49.952524331Z == 20240423102250 AddInterfaceLanguageToUsers: migrating ======================
2025-11-19T09:03:49.952532397Z -- add_column(:users, :interface_language, :string)
2025-11-19T09:03:49.952540423Z    -> 0.0007s
2025-11-19T09:03:49.952548339Z == 20240423102250 AddInterfaceLanguageToUsers: migrated (0.0040s) =============
2025-11-19T09:03:49.952556415Z 
2025-11-19T09:03:49.952564191Z Migrating to AddLockableToUsers (20240610120318)
2025-11-19T09:03:49.952573089Z == 20240610120318 AddLockableToUsers: migrating ===============================
2025-11-19T09:03:49.952582478Z -- change_table(:users)
2025-11-19T09:03:49.952591656Z    -> 0.0017s
2025-11-19T09:03:49.952600815Z == 20240610120318 AddLockableToUsers: migrated (0.0020s) ======================
2025-11-19T09:03:49.952610203Z 
2025-11-19T09:03:49.952619162Z Migrating to AddAttachmentDataToModelFiles (20240614085913)
2025-11-19T09:03:49.952628440Z == 20240614085913 AddAttachmentDataToModelFiles: migrating ====================
2025-11-19T09:03:49.952637819Z -- add_column(:model_files, :attachment_data, :json)
2025-11-19T09:03:49.952657749Z    -> 0.0006s
2025-11-19T09:03:49.952667669Z == 20240614085913 AddAttachmentDataToModelFiles: migrated (0.0009s) ===========
2025-11-19T09:03:49.952677649Z 
2025-11-19T09:03:49.952686728Z Migrating to MoveFileDataIntoShrine (20240615085913)
2025-11-19T09:03:49.952696126Z == 20240615085913 MoveFileDataIntoShrine: migrating ===========================
2025-11-19T09:03:49.952705495Z == 20240615085913 MoveFileDataIntoShrine: migrated (0.0213s) ==================
2025-11-19T09:03:49.952714904Z 
2025-11-19T09:03:49.952723902Z Migrating to AddStorageServiceToLibraries (20240701142651)
2025-11-19T09:03:49.952733211Z == 20240701142651 AddStorageServiceToLibraries: migrating =====================
2025-11-19T09:03:49.952742550Z -- add_column(:libraries, :storage_service, :string, {null: false, default: "filesystem"})
2025-11-19T09:03:49.952752189Z    -> 0.0008s
2025-11-19T09:03:49.952761358Z == 20240701142651 AddStorageServiceToLibraries: migrated (0.0024s) ============
2025-11-19T09:03:49.952770095Z 
2025-11-19T09:03:49.952777811Z Migrating to AddS3FieldsToLibrary (20240703103707)
2025-11-19T09:03:49.952785787Z == 20240703103707 AddS3FieldsToLibrary: migrating =============================
2025-11-19T09:03:49.952793793Z -- add_column(:libraries, :s3_endpoint, :string, {default: nil})
2025-11-19T09:03:49.952801829Z    -> 0.0006s
2025-11-19T09:03:49.952809715Z -- add_column(:libraries, :s3_region, :string, {default: nil})
2025-11-19T09:03:49.952817721Z    -> 0.0006s
2025-11-19T09:03:49.952825627Z -- add_column(:libraries, :s3_bucket, :string, {default: nil})
2025-11-19T09:03:49.952833754Z    -> 0.0006s
2025-11-19T09:03:49.952841639Z -- add_column(:libraries, :s3_access_key_id, :string, {default: nil})
2025-11-19T09:03:49.952849726Z    -> 0.0047s
2025-11-19T09:03:49.952857612Z -- add_column(:libraries, :s3_secret_access_key, :string, {default: nil})
2025-11-19T09:03:49.952865618Z    -> 0.0006s
2025-11-19T09:03:49.952873484Z == 20240703103707 AddS3FieldsToLibrary: migrated (0.0082s) ====================
2025-11-19T09:03:49.952881500Z 
2025-11-19T09:03:49.952889245Z Migrating to ChangeIndexOnLibraryPath (20240703160732)
2025-11-19T09:03:49.952897271Z == 20240703160732 ChangeIndexOnLibraryPath: migrating =========================
2025-11-19T09:03:49.952905308Z -- remove_index(:libraries, :path)
2025-11-19T09:03:49.952913254Z    -> 0.0011s
2025-11-19T09:03:49.952921109Z == 20240703160732 ChangeIndexOnLibraryPath: migrated (0.0018s) ================
2025-11-19T09:03:49.952929136Z 
2025-11-19T09:03:49.952936831Z Migrating to CreateFederailsActors (20240727113215)
2025-11-19T09:03:49.952944777Z == 20240727113215 CreateFederailsActors: migrating ============================
2025-11-19T09:03:49.952961861Z -- create_table(:federails_actors)
2025-11-19T09:03:49.952969968Z    -> 0.0009s
2025-11-19T09:03:49.952977874Z -- foreign_key_exists?(:federails_actors, :users)
2025-11-19T09:03:49.952985830Z    -> 0.0015s
2025-11-19T09:03:49.952993756Z -- remove_foreign_key(:federails_actors, :users)
2025-11-19T09:03:49.953001692Z    -> 0.0123s
2025-11-19T09:03:49.953009527Z -- remove_index(:federails_actors, :user_id)
2025-11-19T09:03:49.953017433Z    -> 0.0004s
2025-11-19T09:03:49.953025319Z -- add_index(:federails_actors, :user_id, {unique: true, name: "index_federails_actors_on_user_id"})
2025-11-19T09:03:49.953033636Z    -> 0.0001s
2025-11-19T09:03:49.953041472Z -- add_foreign_key(:federails_actors, :users)
2025-11-19T09:03:49.953049388Z    -> 0.0105s
2025-11-19T09:03:49.953057294Z == 20240727113215 CreateFederailsActors: migrated (0.0266s) ===================
2025-11-19T09:03:49.953065340Z 
2025-11-19T09:03:49.953073677Z Migrating to CreateFederailsFollowings (20240727113216)
2025-11-19T09:03:49.953081723Z == 20240727113216 CreateFederailsFollowings: migrating ========================
2025-11-19T09:03:49.953089789Z -- create_table(:federails_followings)
2025-11-19T09:03:49.953097725Z    -> 0.0014s
2025-11-19T09:03:49.953105581Z == 20240727113216 CreateFederailsFollowings: migrated (0.0014s) ===============
2025-11-19T09:03:49.953113597Z 
2025-11-19T09:03:49.953121292Z Migrating to CreateFederailsActivities (20240727113217)
2025-11-19T09:03:49.953129218Z == 20240727113217 CreateFederailsActivities: migrating ========================
2025-11-19T09:03:49.953137235Z -- create_table(:federails_activities)
2025-11-19T09:03:49.953145161Z    -> 0.0092s
2025-11-19T09:03:49.953153086Z == 20240727113217 CreateFederailsActivities: migrated (0.0092s) ===============
2025-11-19T09:03:49.953161153Z 
2025-11-19T09:03:49.953168888Z Migrating to ChangeActorEntityRelToPolymorphic (20240731165646)
2025-11-19T09:03:49.953176844Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrating ================
2025-11-19T09:03:49.953184800Z -- remove_foreign_key(:federails_actors, {column: :user_id, to_table: "users"})
2025-11-19T09:03:49.953193007Z    -> 0.0094s
2025-11-19T09:03:49.953200883Z -- remove_index(:federails_actors, :user_id, {unique: true})
2025-11-19T09:03:49.953208859Z    -> 0.0004s
2025-11-19T09:03:49.953216785Z -- change_table(:federails_actors)
2025-11-19T09:03:49.953225743Z    -> 0.0073s
2025-11-19T09:03:49.953233669Z == 20240731165646 ChangeActorEntityRelToPolymorphic: migrated (0.0172s) =======
2025-11-19T09:03:49.953250603Z 
2025-11-19T09:03:49.953258368Z Migrating to CreateFederailsActors (20240731165647)
2025-11-19T09:03:49.953266304Z == 20240731165647 CreateFederailsActors: migrating ============================
2025-11-19T09:03:49.953274291Z == 20240731165647 CreateFederailsActors: migrated (0.0000s) ===================
2025-11-19T09:03:49.953282347Z 
2025-11-19T09:03:49.953290032Z Migrating to CreateMoreFederailsActors (20240802094448)
2025-11-19T09:03:49.953298169Z == 20240802094448 CreateMoreFederailsActors: migrating ========================
2025-11-19T09:03:49.953306195Z == 20240802094448 CreateMoreFederailsActors: migrated (0.0000s) ===============
2025-11-19T09:03:49.953314311Z 
2025-11-19T09:03:49.953322017Z Migrating to BackfillActivities (20240805111500)
2025-11-19T09:03:49.953329943Z == 20240805111500 BackfillActivities: migrating ===============================
2025-11-19T09:03:49.953337939Z == 20240805111500 BackfillActivities: migrated (0.0000s) ======================
2025-11-19T09:03:49.953346095Z 
2025-11-19T09:03:49.953353831Z Migrating to CreateCaberRelations (20240827155630)
2025-11-19T09:03:49.953361847Z == 20240827155630 CreateCaberRelations: migrating =============================
2025-11-19T09:03:49.953369853Z -- create_table(:caber_relations)
2025-11-19T09:03:49.953377779Z    -> 0.0391s
2025-11-19T09:03:49.953385675Z == 20240827155630 CreateCaberRelations: migrated (0.0391s) ====================
2025-11-19T09:03:49.953393761Z 
2025-11-19T09:03:49.953401497Z Migrating to AddDefaultAccessControls (20240830121749)
2025-11-19T09:03:49.953409453Z == 20240830121749 AddDefaultAccessControls: migrating =========================
2025-11-19T09:03:50.580760169Z == 20240830121749 AddDefaultAccessControls: migrated (0.0534s) ================
2025-11-19T09:03:50.580809789Z 
2025-11-19T09:03:50.580820842Z Migrating to RenameDefaultRoles (20240830151650)
2025-11-19T09:03:50.580829188Z == 20240830151650 RenameDefaultRoles: migrating ===============================
2025-11-19T09:03:50.580837375Z == 20240830151650 RenameDefaultRoles: migrated (0.0394s) ======================
2025-11-19T09:03:50.580845481Z 
2025-11-19T09:03:50.580853357Z Migrating to AddPublicIDsToModels (20240904151944)
2025-11-19T09:03:50.580861323Z == 20240904151944 AddPublicIDsToModels: migrating =============================
2025-11-19T09:03:50.580869480Z -- add_column(:models, :public_id, :string)
2025-11-19T09:03:50.580877556Z    -> 0.0008s
2025-11-19T09:03:50.580887536Z -- add_index(:models, :public_id)
2025-11-19T09:03:50.580897656Z    -> 0.0024s
2025-11-19T09:03:50.580906885Z -- add_column(:model_files, :public_id, :string)
2025-11-19T09:03:50.580915963Z    -> 0.0006s
2025-11-19T09:03:50.580949541Z -- add_index(:model_files, :public_id)
2025-11-19T09:03:50.580957667Z    -> 0.0001s
2025-11-19T09:03:50.580966765Z -- add_column(:problems, :public_id, :string)
2025-11-19T09:03:50.580976836Z    -> 0.0006s
2025-11-19T09:03:50.580986285Z -- add_index(:problems, :public_id)
2025-11-19T09:03:50.580994291Z    -> 0.0001s
2025-11-19T09:03:50.581002207Z -- add_column(:creators, :public_id, :string)
2025-11-19T09:03:50.581010233Z    -> 0.0006s
2025-11-19T09:03:50.581018139Z -- add_index(:creators, :public_id)
2025-11-19T09:03:50.581026045Z    -> 0.0001s
2025-11-19T09:03:50.581034011Z -- add_column(:collections, :public_id, :string)
2025-11-19T09:03:50.581042007Z    -> 0.0006s
2025-11-19T09:03:50.581051175Z -- add_index(:collections, :public_id)
2025-11-19T09:03:50.581061326Z    -> 0.0001s
2025-11-19T09:03:50.581070544Z -- add_column(:libraries, :public_id, :string)
2025-11-19T09:03:50.581078571Z    -> 0.0007s
2025-11-19T09:03:50.581086486Z -- add_index(:libraries, :public_id)
2025-11-19T09:03:50.581094362Z    -> 0.0001s
2025-11-19T09:03:50.581102348Z == 20240904151944 AddPublicIDsToModels: migrated (0.0073s) ====================
2025-11-19T09:03:50.581110465Z 
2025-11-19T09:03:50.581118180Z Migrating to GeneratePublicIDsForModels (20240904152358)
2025-11-19T09:03:50.581126176Z == 20240904152358 GeneratePublicIDsForModels: migrating =======================
2025-11-19T09:03:50.581135756Z Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:50.581146076Z == 20240904152358 GeneratePublicIDsForModels: migrated (0.0478s) ==============
2025-11-19T09:03:50.581155876Z 
2025-11-19T09:03:50.581163772Z Migrating to BackfillActivitiesAfterPermissions (20240909100000)
2025-11-19T09:03:50.581171908Z == 20240909100000 BackfillActivitiesAfterPermissions: migrating ===============
2025-11-19T09:03:50.581179955Z == 20240909100000 BackfillActivitiesAfterPermissions: migrated (0.0000s) ======
2025-11-19T09:03:50.581188021Z 
2025-11-19T09:03:50.581195807Z Migrating to DeduplicateRoles (20240923114515)
2025-11-19T09:03:50.581203773Z == 20240923114515 DeduplicateRoles: migrating =================================
2025-11-19T09:03:50.581212390Z == 20240923114515 DeduplicateRoles: migrated (0.1352s) ========================
2025-11-19T09:03:50.581222440Z 
2025-11-19T09:03:50.581232100Z Migrating to AddVirtualColumnsForSorting (20240924122004)
2025-11-19T09:03:50.581240376Z == 20240924122004 AddVirtualColumnsForSorting: migrating ======================
2025-11-19T09:03:50.581250166Z -- add_column(:models, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-11-19T09:03:50.581268844Z    -> 0.1582s
2025-11-19T09:03:50.581276990Z -- add_index(:models, :name_lower)
2025-11-19T09:03:50.581284966Z    -> 0.0002s
2025-11-19T09:03:50.581292902Z -- add_column(:creators, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-11-19T09:03:50.581303463Z    -> 0.0068s
2025-11-19T09:03:50.581313293Z -- add_index(:creators, :name_lower)
2025-11-19T09:03:50.581321830Z    -> 0.0001s
2025-11-19T09:03:50.581329776Z -- add_column(:collections, :name_lower, :virtual, {type: :string, as: "LOWER(name)", stored: true})
2025-11-19T09:03:50.581338013Z    -> 0.0086s
2025-11-19T09:03:50.581345919Z -- add_index(:collections, :name_lower)
2025-11-19T09:03:50.581353835Z    -> 0.0002s
2025-11-19T09:03:50.581361751Z == 20240924122004 AddVirtualColumnsForSorting: migrated (0.1746s) =============
2025-11-19T09:03:50.581369817Z 
2025-11-19T09:03:50.581378094Z Migrating to AddKeypairToActors (20240926162407)
2025-11-19T09:03:50.581388164Z == 20240926162407 AddKeypairToActors: migrating ===============================
2025-11-19T09:03:50.581398274Z -- change_table(:federails_actors)
2025-11-19T09:03:50.581406290Z    -> 0.0015s
2025-11-19T09:03:50.581414206Z == 20240926162407 AddKeypairToActors: migrated (0.0015s) ======================
2025-11-19T09:03:50.581422273Z 
2025-11-19T09:03:50.581430068Z Migrating to AddUuids (20241004194445)
2025-11-19T09:03:50.581437974Z == 20241004194445 AddUuids: migrating =========================================
2025-11-19T09:03:50.581446010Z -- change_table(:federails_actors)
2025-11-19T09:03:50.581454027Z    -> 0.0029s
2025-11-19T09:03:50.581462764Z -- change_table(:federails_activities)
2025-11-19T09:03:50.581472714Z    -> 0.0009s
2025-11-19T09:03:50.581482293Z -- change_table(:federails_followings)
2025-11-19T09:03:50.581490440Z    -> 0.0009s
2025-11-19T09:03:50.581498416Z == 20241004194445 AddUuids: migrated (0.0047s) ================================
2025-11-19T09:03:50.581506492Z 
2025-11-19T09:03:50.581514208Z Migrating to CreateComments (20241007182824)
2025-11-19T09:03:50.581522274Z == 20241007182824 CreateComments: migrating ===================================
2025-11-19T09:03:50.581530330Z -- create_table(:comments)
2025-11-19T09:03:50.581538246Z    -> 0.0019s
2025-11-19T09:03:50.581547395Z == 20241007182824 CreateComments: migrated (0.0020s) ==========================
2025-11-19T09:03:50.581557585Z 
2025-11-19T09:03:50.581566493Z Migrating to AddSystemToComments (20241009122540)
2025-11-19T09:03:50.581574569Z == 20241009122540 AddSystemToComments: migrating ==============================
2025-11-19T09:03:50.581592355Z -- add_column(:comments, :system, :boolean, {null: false, default: false})
2025-11-19T09:03:50.581600622Z    -> 0.0008s
2025-11-19T09:03:50.581608528Z == 20241009122540 AddSystemToComments: migrated (0.0008s) =====================
2025-11-19T09:03:50.581616544Z 
2025-11-19T09:03:50.581624790Z Migrating to BackfillActivitiesAfterUuids (20241013215000)
2025-11-19T09:03:50.581634871Z == 20241013215000 BackfillActivitiesAfterUuids: migrating =====================
2025-11-19T09:03:50.581645051Z == 20241013215000 BackfillActivitiesAfterUuids: migrated (0.0015s) ============
2025-11-19T09:03:50.581653298Z 
2025-11-19T09:03:50.581661073Z Migrating to AddOmniauthToUsers (20241015090803)
2025-11-19T09:03:50.581669019Z == 20241015090803 AddOmniauthToUsers: migrating ===============================
2025-11-19T09:03:50.581677096Z -- add_column(:users, :auth_provider, :string)
2025-11-19T09:03:50.581685633Z    -> 0.0008s
2025-11-19T09:03:50.581693569Z -- add_column(:users, :auth_uid, :string)
2025-11-19T09:03:50.581701565Z    -> 0.0007s
2025-11-19T09:03:50.581710343Z == 20241015090803 AddOmniauthToUsers: migrated (0.0015s) ======================
2025-11-19T09:03:50.581720593Z 
2025-11-19T09:03:50.581729952Z Migrating to AddSensitiveFlagToModelsAndComments (20241017093301)
2025-11-19T09:03:50.581738179Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrating ==============
2025-11-19T09:03:50.581746255Z -- add_column(:models, :sensitive, :boolean, {null: false, default: false})
2025-11-19T09:03:50.581754341Z    -> 0.0008s
2025-11-19T09:03:50.581762277Z -- add_column(:comments, :sensitive, :boolean, {null: false, default: false})
2025-11-19T09:03:50.581770363Z    -> 0.0007s
2025-11-19T09:03:50.581778249Z == 20241017093301 AddSensitiveFlagToModelsAndComments: migrated (0.0016s) =====
2025-11-19T09:03:50.581786306Z 
2025-11-19T09:03:50.581795234Z Migrating to AddSensitiveContentHandlingToUsers (20241017113112)
2025-11-19T09:03:50.581805524Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrating ===============
2025-11-19T09:03:50.581814813Z -- add_column(:users, :sensitive_content_handling, :string, {default: nil})
2025-11-19T09:03:50.581822959Z    -> 0.0008s
2025-11-19T09:03:50.581830875Z == 20241017113112 AddSensitiveContentHandlingToUsers: migrated (0.0008s) ======
2025-11-19T09:03:50.581838881Z 
2025-11-19T09:03:50.581846617Z Migrating to AddPublicIDsToUsers (20241021124608)
2025-11-19T09:03:50.581854593Z == 20241021124608 AddPublicIDsToUsers: migrating ==============================
2025-11-19T09:03:50.581862639Z -- change_table(:users)
2025-11-19T09:03:50.581870615Z    -> 0.0009s
2025-11-19T09:03:50.581880315Z == 20241021124608 AddPublicIDsToUsers: migrated (0.0010s) =====================
2025-11-19T09:03:50.581900606Z 
2025-11-19T09:03:50.581908532Z Migrating to CreatePublicIDsForUsers (20241021125322)
2025-11-19T09:03:50.581916568Z == 20241021125322 CreatePublicIDsForUsers: migrating ==========================
2025-11-19T09:03:50.581924634Z == 20241021125322 CreatePublicIDsForUsers: migrated (0.0080s) =================
2025-11-19T09:03:50.581932680Z 
2025-11-19T09:03:50.581940436Z Migrating to RemoveUnneededIndexes (20241025110218)
2025-11-19T09:03:50.581948472Z == 20241025110218 RemoveUnneededIndexes: migrating ============================
2025-11-19T09:03:50.581957290Z -- remove_index(:favorites, {name: "index_favorites_on_favoritable", column: [:favoritable_type, :favoritable_id]})
2025-11-19T09:03:50.581967901Z    -> 0.0008s
2025-11-19T09:03:50.581977761Z -- remove_index(:federails_followings, {name: "index_federails_followings_on_actor_id", column: :actor_id})
2025-11-19T09:03:50.581986318Z    -> 0.0012s
2025-11-19T09:03:50.581994164Z -- remove_index(:roles, {name: "index_roles_on_name", column: :name})
2025-11-19T09:03:50.582002401Z    -> 0.0004s
2025-11-19T09:03:50.582010307Z -- remove_index(:taggings, {name: "index_taggings_on_tag_id", column: :tag_id})
2025-11-19T09:03:50.582018633Z    -> 0.0009s
2025-11-19T09:03:50.582026529Z -- remove_index(:taggings, {name: "index_taggings_on_taggable_id", column: :taggable_id})
2025-11-19T09:03:50.582034836Z    -> 0.0008s
2025-11-19T09:03:50.582045127Z -- remove_index(:taggings, {name: "index_taggings_on_tagger_id", column: :tagger_id})
2025-11-19T09:03:50.582055598Z    -> 0.0008s
2025-11-19T09:03:50.582064516Z -- remove_index(:users_roles, {name: "index_users_roles_on_user_id", column: :user_id})
2025-11-19T09:03:50.582072772Z    -> 0.0004s
2025-11-19T09:03:50.582080678Z == 20241025110218 RemoveUnneededIndexes: migrated (0.0055s) ===================
2025-11-19T09:03:50.582088825Z 
2025-11-19T09:03:50.582096670Z Migrating to AddInProgressToProblems (20241105121830)
2025-11-19T09:03:50.582104697Z == 20241105121830 AddInProgressToProblems: migrating ==========================
2025-11-19T09:03:50.582112753Z -- add_column(:problems, :in_progress, :boolean, {default: false, null: false})
2025-11-19T09:03:50.582121320Z    -> 0.0008s
2025-11-19T09:03:50.582131110Z == 20241105121830 AddInProgressToProblems: migrated (0.0008s) =================
2025-11-19T09:03:50.582141270Z 
2025-11-19T09:03:50.582149316Z Migrating to ClearStuckProblems (20241118155027)
2025-11-19T09:03:50.582157433Z == 20241118155027 ClearStuckProblems: migrating ===============================
2025-11-19T09:03:50.582165569Z == 20241118155027 ClearStuckProblems: migrated (0.0181s) ======================
2025-11-19T09:03:50.582183886Z 
2025-11-19T09:03:50.582191732Z Migrating to AddApprovedToUser (20241122121621)
2025-11-19T09:03:50.582204257Z == 20241122121621 AddApprovedToUser: migrating ================================
2025-11-19T09:03:50.582214377Z -- change_table(:users)
2025-11-19T09:03:50.582224378Z    -> 0.0017s
2025-11-19T09:03:50.582232514Z == 20241122121621 AddApprovedToUser: migrated (0.0017s) =======================
2025-11-19T09:03:50.582240731Z 
2025-11-19T09:03:50.582248516Z Migrating to CreateFederailsModerationReports (20241128162213)
2025-11-19T09:03:50.582256532Z == 20241128162213 CreateFederailsModerationReports: migrating =================
2025-11-19T09:03:50.582264659Z -- create_table(:federails_moderation_reports)
2025-11-19T09:03:50.582272845Z    -> 0.0028s
2025-11-19T09:03:50.582280761Z == 20241128162213 CreateFederailsModerationReports: migrated (0.0029s) ========
2025-11-19T09:03:50.582289679Z 
2025-11-19T09:03:50.582299569Z Migrating to CreateFederailsModerationDomainBlocks (20241128162214)
2025-11-19T09:03:50.582309569Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrating ============
2025-11-19T09:03:50.582317786Z -- create_table(:federails_moderation_domain_blocks)
2025-11-19T09:03:50.582325762Z    -> 0.0009s
2025-11-19T09:03:50.582333678Z == 20241128162214 CreateFederailsModerationDomainBlocks: migrated (0.0010s) ===
2025-11-19T09:03:50.582341774Z 
2025-11-19T09:03:50.582349520Z Migrating to AddFederationAttributesToComments (20250114105808)
2025-11-19T09:03:50.582357626Z == 20250114105808 AddFederationAttributesToComments: migrating ================
2025-11-19T09:03:50.582365722Z -- change_column_null(:comments, :commenter_id, true)
2025-11-19T09:03:50.582374991Z    -> 0.0077s
2025-11-19T09:03:50.582385021Z -- change_column_null(:comments, :commenter_type, true)
2025-11-19T09:03:50.582394230Z    -> 0.0074s
2025-11-19T09:03:50.582402206Z -- add_column(:comments, :federated_url, :string, {null: true, default: nil})
2025-11-19T09:03:50.582410252Z    -> 0.0008s
2025-11-19T09:03:50.582418158Z -- add_reference(:comments, :federails_actor, {null: true, foreign_key: true})
2025-11-19T09:03:50.582426274Z    -> 0.0105s
2025-11-19T09:03:51.361163052Z == 20250114105808 AddFederationAttributesToComments: migrated (0.0278s) =======
2025-11-19T09:03:51.361204345Z 
2025-11-19T09:03:51.361213553Z Migrating to AddS3PathStyleToLibrary (20250121105010)
2025-11-19T09:03:51.361221139Z == 20250121105010 AddS3PathStyleToLibrary: migrating ==========================
2025-11-19T09:03:51.361229024Z -- add_column(:libraries, :s3_path_style, :boolean, {default: true, null: false})
2025-11-19T09:03:51.361236830Z    -> 0.0010s
2025-11-19T09:03:51.361244465Z == 20250121105010 AddS3PathStyleToLibrary: migrated (0.0010s) =================
2025-11-19T09:03:51.361284566Z 
2025-11-19T09:03:51.361291991Z Migrating to MakePublicIDsLowercase (20250121164452)
2025-11-19T09:03:51.361299617Z == 20250121164452 MakePublicIDsLowercase: migrating ===========================
2025-11-19T09:03:51.361307372Z == 20250121164452 MakePublicIDsLowercase: migrated (0.1263s) ==================
2025-11-19T09:03:51.361314657Z 
2025-11-19T09:03:51.361321551Z Migrating to AddExtensionsToFederailsActors (20250122171731)
2025-11-19T09:03:51.361328865Z == 20250122171731 AddExtensionsToFederailsActors: migrating ===================
2025-11-19T09:03:51.361336841Z -- add_column(:federails_actors, :extensions, :json, {default: nil, null: true})
2025-11-19T09:03:51.361344086Z    -> 0.0029s
2025-11-19T09:03:51.361351451Z == 20250122171731 AddExtensionsToFederailsActors: migrated (0.0030s) ==========
2025-11-19T09:03:51.361358896Z 
2025-11-19T09:03:51.361365800Z Migrating to AddCreatorToCollections (20250222000000)
2025-11-19T09:03:51.361372694Z == 20250222000000 AddCreatorToCollections: migrating ==========================
2025-11-19T09:03:51.361380149Z -- add_reference(:collections, :creator, {null: true, foreign_key: true})
2025-11-19T09:03:51.361387223Z    -> 0.0237s
2025-11-19T09:03:51.361395079Z == 20250222000000 AddCreatorToCollections: migrated (0.0237s) =================
2025-11-19T09:03:51.361403265Z 
2025-11-19T09:03:51.361410460Z Migrating to AddLocalToActors (20250305171530)
2025-11-19T09:03:51.361418125Z == 20250305171530 AddLocalToActors: migrating =================================
2025-11-19T09:03:51.361426201Z -- add_column(:federails_actors, :local, :boolean, {null: false, default: false})
2025-11-19T09:03:51.361433446Z    -> 0.0009s
2025-11-19T09:03:51.361439849Z -- exec_update("UPDATE federails_actors SET local=true WHERE entity_type IS NOT NULL")
2025-11-19T09:03:51.361446623Z    -> 0.0018s
2025-11-19T09:03:51.361452935Z    -> 0 rows
2025-11-19T09:03:51.361459188Z == 20250305171530 AddLocalToActors: migrated (0.0058s) ========================
2025-11-19T09:03:51.361465681Z 
2025-11-19T09:03:51.361472114Z Migrating to AddActorTypeToActors (20250407160721)
2025-11-19T09:03:51.361479890Z == 20250407160721 AddActorTypeToActors: migrating =============================
2025-11-19T09:03:51.361487555Z -- add_column(:federails_actors, :actor_type, :string, {null: true})
2025-11-19T09:03:51.361495321Z    -> 0.0010s
2025-11-19T09:03:51.361503186Z == 20250407160721 AddActorTypeToActors: migrated (0.0010s) ====================
2025-11-19T09:03:51.361511012Z 
2025-11-19T09:03:51.361518628Z Migrating to AddTombstonedAtToActors (20250407160722)
2025-11-19T09:03:51.361528638Z == 20250407160722 AddTombstonedAtToActors: migrating ==========================
2025-11-19T09:03:51.361547235Z -- add_column(:federails_actors, :tombstoned_at, :datetime, {default: nil})
2025-11-19T09:03:51.361555251Z    -> 0.0015s
2025-11-19T09:03:51.361562576Z == 20250407160722 AddTombstonedAtToActors: migrated (0.0016s) =================
2025-11-19T09:03:51.361570452Z 
2025-11-19T09:03:51.361577977Z Migrating to CreateDoorkeeperTables (20250408111644)
2025-11-19T09:03:51.361585873Z == 20250408111644 CreateDoorkeeperTables: migrating ===========================
2025-11-19T09:03:51.361593669Z -- create_table(:oauth_applications)
2025-11-19T09:03:51.361601615Z    -> 0.0004s
2025-11-19T09:03:51.361609571Z -- add_index(:oauth_applications, :uid, {unique: true})
2025-11-19T09:03:51.361617497Z    -> 0.0002s
2025-11-19T09:03:51.361625162Z -- create_table(:oauth_access_grants)
2025-11-19T09:03:51.361634541Z    -> 0.0006s
2025-11-19T09:03:51.361642377Z -- add_index(:oauth_access_grants, :token, {unique: true})
2025-11-19T09:03:51.361650032Z    -> 0.0001s
2025-11-19T09:03:51.361657968Z -- add_foreign_key(:oauth_access_grants, :oauth_applications, {column: :application_id})
2025-11-19T09:03:51.361666024Z    -> 0.0073s
2025-11-19T09:03:51.361673780Z -- create_table(:oauth_access_tokens)
2025-11-19T09:03:51.361681335Z    -> 0.0006s
2025-11-19T09:03:51.361689051Z -- add_index(:oauth_access_tokens, :token, {unique: true})
2025-11-19T09:03:51.361697017Z    -> 0.0002s
2025-11-19T09:03:51.361704883Z -- add_index(:oauth_access_tokens, :refresh_token, {unique: true})
2025-11-19T09:03:51.361712638Z    -> 0.0001s
2025-11-19T09:03:51.361720203Z -- add_foreign_key(:oauth_access_tokens, :oauth_applications, {column: :application_id})
2025-11-19T09:03:51.361728330Z    -> 0.0089s
2025-11-19T09:03:51.361736055Z -- add_foreign_key(:oauth_access_grants, :users, {column: :resource_owner_id})
2025-11-19T09:03:51.361743079Z    -> 0.0071s
2025-11-19T09:03:51.361749763Z -- add_foreign_key(:oauth_access_tokens, :users, {column: :resource_owner_id})
2025-11-19T09:03:51.361756807Z    -> 0.0087s
2025-11-19T09:03:51.361763551Z == 20250408111644 CreateDoorkeeperTables: migrated (0.0344s) ==================
2025-11-19T09:03:51.361770284Z 
2025-11-19T09:03:51.361776938Z Migrating to AddOwnerToApplication (20250408145956)
2025-11-19T09:03:51.361783691Z == 20250408145956 AddOwnerToApplication: migrating ============================
2025-11-19T09:03:51.361790866Z -- add_column(:oauth_applications, :owner_id, :bigint, {null: true})
2025-11-19T09:03:51.361798661Z    -> 0.0009s
2025-11-19T09:03:51.361806437Z -- add_column(:oauth_applications, :owner_type, :string, {null: true})
2025-11-19T09:03:51.361824363Z    -> 0.0008s
2025-11-19T09:03:51.361831838Z -- add_index(:oauth_applications, [:owner_id, :owner_type])
2025-11-19T09:03:51.361839684Z    -> 0.0002s
2025-11-19T09:03:51.361846558Z == 20250408145956 AddOwnerToApplication: migrated (0.0069s) ===================
2025-11-19T09:03:51.361853782Z 
2025-11-19T09:03:51.361860636Z Migrating to RemoveDefaultActorEntityType (20250409120155)
2025-11-19T09:03:51.361868392Z == 20250409120155 RemoveDefaultActorEntityType: migrating =====================
2025-11-19T09:03:51.361876618Z -- change_column_default(:federails_actors, :entity_type, nil)
2025-11-19T09:03:51.361885246Z    -> 0.0105s
2025-11-19T09:03:51.361892901Z == 20250409120155 RemoveDefaultActorEntityType: migrated (0.0118s) ============
2025-11-19T09:03:51.361900877Z 
2025-11-19T09:03:51.361908503Z Migrating to AddQuotaToUsers (20250409125753)
2025-11-19T09:03:51.361915747Z == 20250409125753 AddQuotaToUsers: migrating ==================================
2025-11-19T09:03:51.361922942Z -- add_column(:users, :quota, :integer, {default: 1, null: false})
2025-11-19T09:03:51.361930447Z    -> 0.0009s
2025-11-19T09:03:51.361938002Z -- add_column(:users, :quota_use_site_default, :boolean, {default: true, null: false})
2025-11-19T09:03:51.361945838Z    -> 0.0008s
2025-11-19T09:03:51.361953683Z == 20250409125753 AddQuotaToUsers: migrated (0.0030s) =========================
2025-11-19T09:03:51.361961780Z 
2025-11-19T09:03:51.361969846Z Migrating to AddLowercaseFilenameVirtualFieldToModelFiles (20250423094525)
2025-11-19T09:03:51.361978012Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrating =====
2025-11-19T09:03:51.361985738Z -- add_column(:model_files, :filename_lower, :virtual, {type: :string, as: "LOWER(filename)", stored: true})
2025-11-19T09:03:51.361993864Z    -> 0.0120s
2025-11-19T09:03:51.362001580Z -- add_index(:model_files, :filename_lower)
2025-11-19T09:03:51.362009416Z    -> 0.0002s
2025-11-19T09:03:51.362017221Z == 20250423094525 AddLowercaseFilenameVirtualFieldToModelFiles: migrated (0.0135s) 
2025-11-19T09:03:51.362025248Z 
2025-11-19T09:03:51.362032953Z Migrating to AddUniqueIndexToLinks (20250425104619)
2025-11-19T09:03:51.362040909Z == 20250425104619 AddUniqueIndexToLinks: migrating ============================
2025-11-19T09:03:51.362048885Z -- add_index(:links, [:linkable_id, :linkable_type, :url])
2025-11-19T09:03:51.362056350Z    -> 0.0002s
2025-11-19T09:03:51.362063986Z == 20250425104619 AddUniqueIndexToLinks: migrated (0.0011s) ===================
2025-11-19T09:03:51.362072072Z 
2025-11-19T09:03:51.362079667Z Migrating to AddPreviewToModelFile (20250520111046)
2025-11-19T09:03:51.362097724Z == 20250520111046 AddPreviewToModelFile: migrating ============================
2025-11-19T09:03:51.362105549Z -- add_column(:model_files, :previewable, :boolean, {default: false, null: false})
2025-11-19T09:03:51.362112854Z    -> 0.0009s
2025-11-19T09:03:51.362121171Z == 20250520111046 AddPreviewToModelFile: migrated (0.0018s) ===================
2025-11-19T09:03:51.362128205Z 
2025-11-19T09:03:51.362134928Z Migrating to CreateAltchaSolutions (20250609210440)
2025-11-19T09:03:51.362142494Z == 20250609210440 CreateAltchaSolutions: migrating ============================
2025-11-19T09:03:51.362150309Z -- create_table(:altcha_solutions)
2025-11-19T09:03:51.362158095Z    -> 0.0004s
2025-11-19T09:03:51.362166181Z -- add_index(:altcha_solutions, [:algorithm, :challenge, :salt, :signature, :number], {unique: true, name: "index_altcha_solutions"})
2025-11-19T09:03:51.362173767Z    -> 0.0002s
2025-11-19T09:03:51.362180049Z == 20250609210440 CreateAltchaSolutions: migrated (0.0016s) ===================
2025-11-19T09:03:51.362186362Z 
2025-11-19T09:03:51.362192434Z Migrating to AddIndexableFields (20250620141805)
2025-11-19T09:03:51.362198667Z == 20250620141805 AddIndexableFields: migrating ===============================
2025-11-19T09:03:51.362204979Z -- change_table(:models)
2025-11-19T09:03:51.362212074Z    -> 0.0024s
2025-11-19T09:03:51.362219789Z -- change_table(:creators)
2025-11-19T09:03:51.362227445Z    -> 0.0017s
2025-11-19T09:03:51.362234359Z -- change_table(:collections)
2025-11-19T09:03:51.362240561Z    -> 0.0017s
2025-11-19T09:03:51.362247505Z == 20250620141805 AddIndexableFields: migrated (0.0058s) ======================
2025-11-19T09:03:51.362253928Z 
2025-11-19T09:03:51.362260331Z Migrating to ChangeIndexableFromIntegerToString (20250621223410)
2025-11-19T09:03:51.362266664Z == 20250621223410 ChangeIndexableFromIntegerToString: migrating ===============
2025-11-19T09:03:51.362273016Z -- change_column(:models, :indexable, :string)
2025-11-19T09:03:51.362280582Z    -> 0.0275s
2025-11-19T09:03:51.362288317Z -- change_column(:models, :ai_indexable, :string)
2025-11-19T09:03:51.362296534Z    -> 0.0172s
2025-11-19T09:03:51.362303348Z -- change_column(:creators, :indexable, :string)
2025-11-19T09:03:51.362309610Z    -> 0.0086s
2025-11-19T09:03:51.362315833Z -- change_column(:creators, :ai_indexable, :string)
2025-11-19T09:03:51.362322105Z    -> 0.0088s
2025-11-19T09:03:51.362328298Z -- change_column(:collections, :indexable, :string)
2025-11-19T09:03:51.362334580Z    -> 0.0586s
2025-11-19T09:03:51.362341284Z -- change_column(:collections, :ai_indexable, :string)
2025-11-19T09:03:51.362358559Z    -> 0.0145s
2025-11-19T09:03:51.362366254Z == 20250621223410 ChangeIndexableFromIntegerToString: migrated (0.1356s) ======
2025-11-19T09:03:51.362374130Z 
2025-11-19T09:03:51.362381836Z Migrating to AddOrderIndexesToTables (20250629212656)
2025-11-19T09:03:51.362389772Z == 20250629212656 AddOrderIndexesToTables: migrating ==========================
2025-11-19T09:03:51.362397868Z -- change_table(:models)
2025-11-19T09:03:51.362405984Z    -> 0.0004s
2025-11-19T09:03:51.362413980Z -- change_table(:creators)
2025-11-19T09:03:51.362422037Z    -> 0.0003s
2025-11-19T09:03:51.362429902Z -- change_table(:collections)
2025-11-19T09:03:51.362437969Z    -> 0.0003s
2025-11-19T09:03:51.362445955Z == 20250629212656 AddOrderIndexesToTables: migrated (0.0009s) =================
2025-11-19T09:03:51.362454151Z 
2025-11-19T09:03:51.362461867Z Migrating to AddIndexOnLinkUrl (20250716093106)
2025-11-19T09:03:51.362470053Z == 20250716093106 AddIndexOnLinkUrl: migrating ================================
2025-11-19T09:03:51.362478300Z -- change_table(:links)
2025-11-19T09:03:51.362486166Z    -> 0.0002s
2025-11-19T09:03:51.362493971Z == 20250716093106 AddIndexOnLinkUrl: migrated (0.0002s) =======================
2025-11-19T09:03:51.362502208Z 
2025-11-19T09:03:51.362510024Z Migrating to AddSyncedAtToLinks (20250724094951)
2025-11-19T09:03:51.362518120Z == 20250724094951 AddSyncedAtToLinks: migrating ===============================
2025-11-19T09:03:51.362526226Z -- add_column(:links, :synced_at, :datetime)
2025-11-19T09:03:51.362534002Z    -> 0.0011s
2025-11-19T09:03:51.362541848Z == 20250724094951 AddSyncedAtToLinks: migrated (0.0011s) ======================
2025-11-19T09:03:51.362549994Z 
2025-11-19T09:03:51.362557840Z Migrating to CreateFaspClientProviders (20250806142734)
2025-11-19T09:03:51.362565906Z == 20250806142734 CreateFaspClientProviders: migrating ========================
2025-11-19T09:03:51.362574453Z -- create_table(:fasp_client_providers)
2025-11-19T09:03:51.362582490Z    -> 0.0469s
2025-11-19T09:03:51.362590225Z == 20250806142734 CreateFaspClientProviders: migrated (0.0469s) ===============
2025-11-19T09:03:51.362598111Z 
2025-11-19T09:03:51.362605175Z Migrating to CreateFaspClientEventSubscriptions (20250908112415)
2025-11-19T09:03:51.362612931Z == 20250908112415 CreateFaspClientEventSubscriptions: migrating ===============
2025-11-19T09:03:51.362620306Z -- create_table(:fasp_client_event_subscriptions)
2025-11-19T09:03:51.362627170Z    -> 0.0167s
2025-11-19T09:03:51.512717060Z == 20250908112415 CreateFaspClientEventSubscriptions: migrated (0.0168s) ======
2025-11-19T09:03:51.512754495Z 
2025-11-19T09:03:51.512782361Z Migrating to CreateFaspClientBackfillRequests (20250908165009)
2025-11-19T09:03:51.512789887Z == 20250908165009 CreateFaspClientBackfillRequests: migrating =================
2025-11-19T09:03:51.512796229Z -- create_table(:fasp_client_backfill_requests)
2025-11-19T09:03:51.512802372Z    -> 0.0072s
2025-11-19T09:03:51.512808905Z == 20250908165009 CreateFaspClientBackfillRequests: migrated (0.0072s) ========
2025-11-19T09:03:51.512815268Z 
2025-11-19T09:03:51.512821270Z Migrating to AddImagesToCreators (20250922155445)
2025-11-19T09:03:51.512827452Z == 20250922155445 AddImagesToCreators: migrating ==============================
2025-11-19T09:03:51.512834216Z -- add_column(:creators, :avatar_data, :json)
2025-11-19T09:03:51.512840398Z    -> 0.0011s
2025-11-19T09:03:51.512846521Z -- add_column(:creators, :banner_data, :json)
2025-11-19T09:03:51.512853715Z    -> 0.0009s
2025-11-19T09:03:51.512861501Z == 20250922155445 AddImagesToCreators: migrated (0.0021s) =====================
2025-11-19T09:03:51.512868715Z 
2025-11-19T09:03:51.512874667Z Migrating to CreateFederailsHosts (20251010145758)
2025-11-19T09:03:51.512880840Z == 20251010145758 CreateFederailsHosts: migrating =============================
2025-11-19T09:03:51.512887042Z -- create_table(:federails_hosts)
2025-11-19T09:03:51.512893125Z    -> 0.0220s
2025-11-19T09:03:51.512899177Z == 20251010145758 CreateFederailsHosts: migrated (0.0221s) ====================
2025-11-19T09:03:51.512905319Z 
2025-11-19T09:03:51.512911221Z Migrating to AddTourStateToUsers (20251027152904)
2025-11-19T09:03:51.512917333Z == 20251027152904 AddTourStateToUsers: migrating ==============================
2025-11-19T09:03:51.512923486Z -- add_column(:users, :tour_state, :json, {default: {completed: []}})
2025-11-19T09:03:51.512930099Z    -> 0.0295s
2025-11-19T09:03:51.512937845Z == 20251027152904 AddTourStateToUsers: migrated (0.0295s) =====================
2025-11-19T09:03:51.512945660Z 
2025-11-19T09:03:51.512951753Z Migrating to AddSortOrderToUsers (20251105110434)
2025-11-19T09:03:51.512957855Z == 20251105110434 AddSortOrderToUsers: migrating ==============================
2025-11-19T09:03:51.512964198Z -- add_column(:users, :sort_order, :integer, {default: 0, null: false})
2025-11-19T09:03:51.512970590Z    -> 0.0127s
2025-11-19T09:03:51.512980050Z == 20251105110434 AddSortOrderToUsers: migrated (0.0128s) =====================
2025-11-19T09:03:51.512986322Z 
2025-11-19T09:03:51.592750660Z s6-rc: info: service init-manyfold-config successfully started
2025-11-19T09:03:51.592974911Z s6-rc: info: service init-config-end: starting
2025-11-19T09:03:51.594399159Z s6-rc: info: service init-config-end successfully started
2025-11-19T09:03:51.594543970Z s6-rc: info: service init-mods: starting
2025-11-19T09:03:51.595667453Z s6-rc: info: service init-mods successfully started
2025-11-19T09:03:51.595813567Z s6-rc: info: service init-mod-universal-redis-add-package: starting
2025-11-19T09:03:51.602649299Z s6-rc: info: service init-mod-universal-redis-add-package successfully started
2025-11-19T09:03:51.602801766Z s6-rc: info: service init-mods-package-install: starting
2025-11-19T09:03:51.610885492Z [pkg-install-init] **** Installing all mod packages ****
2025-11-19T09:03:51.619392350Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/main/x86_64/APKINDEX.tar.gz
2025-11-19T09:03:51.706003573Z fetch http://dl-cdn.alpinelinux.org/alpine/v3.22/community/x86_64/APKINDEX.tar.gz
2025-11-19T09:03:52.045046642Z (1/1) Installing redis (8.0.4-r0)
2025-11-19T09:03:52.054124960Z Executing redis-8.0.4-r0.pre-install
2025-11-19T09:03:52.093422882Z Executing redis-8.0.4-r0.post-install
2025-11-19T09:03:52.102048028Z Executing busybox-1.37.0-r19.trigger
2025-11-19T09:03:52.115811679Z OK: 115 MiB in 109 packages
2025-11-19T09:03:52.206976000Z s6-rc: info: service init-mods-package-install successfully started
2025-11-19T09:03:52.207139739Z s6-rc: info: service init-mods-end: starting
2025-11-19T09:03:52.208605661Z s6-rc: info: service init-mods-end successfully started
2025-11-19T09:03:52.208807657Z s6-rc: info: service init-custom-files: starting
2025-11-19T09:03:52.216373551Z [custom-init] No custom files found, skipping...
2025-11-19T09:03:52.216908758Z s6-rc: info: service init-custom-files successfully started
2025-11-19T09:03:52.217322952Z s6-rc: info: service init-services: starting
2025-11-19T09:03:52.219335244Z s6-rc: info: service init-services successfully started
2025-11-19T09:03:52.219487210Z s6-rc: info: service svc-mod-universal-redis: starting
2025-11-19T09:03:52.219672513Z s6-rc: info: service svc-manyfold: starting
2025-11-19T09:03:52.219862074Z s6-rc: info: service svc-cron: starting
2025-11-19T09:03:52.222329021Z s6-rc: info: service svc-mod-universal-redis successfully started
2025-11-19T09:03:52.222759097Z s6-rc: info: service svc-cron successfully started
2025-11-19T09:03:52.232311450Z 282:C 19 Nov 2025 09:03:52.232 # 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-11-19T09:03:52.232367392Z 282:C 19 Nov 2025 09:03:52.232 * oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
2025-11-19T09:03:52.232383014Z 282:C 19 Nov 2025 09:03:52.232 * Redis version=8.0.4, bits=64, commit=00000000, modified=1, pid=282, just started
2025-11-19T09:03:52.232391611Z 282:C 19 Nov 2025 09:03:52.232 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
2025-11-19T09:03:52.233037852Z 282:M 19 Nov 2025 09:03:52.232 * monotonic clock: POSIX clock_gettime
2025-11-19T09:03:52.233496265Z 282:M 19 Nov 2025 09:03:52.233 * Running mode=standalone, port=6379.
2025-11-19T09:03:52.233832612Z 282:M 19 Nov 2025 09:03:52.233 * Server initialized
2025-11-19T09:03:52.233866721Z 282:M 19 Nov 2025 09:03:52.233 * Ready to accept connections tcp
2025-11-19T09:03:52.386255530Z 09:03:52 rails.1              | started with pid 302
2025-11-19T09:03:52.386283697Z 09:03:52 default_worker.1     | started with pid 303
2025-11-19T09:03:52.386307986Z 09:03:52 performance_worker.1 | started with pid 304
2025-11-19T09:03:55.129941874Z 09:03:55 rails.1              | => Booting Puma
2025-11-19T09:03:55.131673049Z 09:03:55 rails.1              | => Rails 8.0.2.1 application starting in production 
2025-11-19T09:03:55.131686126Z 09:03:55 rails.1              | => Run `bin/rails server --help` for more startup options
2025-11-19T09:03:55.675518256Z 09:03:55 performance_worker.1 | Server: 02f5c4735d80, Context: rails, Role: web, data: {cpu: {one_min: 3.62, five_min: 2.36, fifteen_min: 2.1}, memory: 0.197009408e9, disk: {available: 840410599424, total: 938656133120, used: 98245533696}}
2025-11-19T09:03:55.684132319Z 09:03:55 default_worker.1     | Server: 02f5c4735d80, Context: rails, Role: web, data: {cpu: {one_min: 3.62, five_min: 2.36, fifteen_min: 2.1}, memory: 0.193949696e9, disk: {available: 840410517504, total: 938656133120, used: 98245615616}}
2025-11-19T09:03:57.759037589Z 09:03:57 performance_worker.1 | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:57.760897314Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.760Z pid=304 tid=234: Sidekiq 8.0.9 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-11-19T09:03:57.765603309Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.765Z pid=304 tid=234: Cron Jobs - added job with name clear-shrine-cache in the namespace default
2025-11-19T09:03:57.766796992Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.766Z pid=304 tid=234: Cron Jobs - added job with name clear-downloads in the namespace default
2025-11-19T09:03:57.832946698Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.832Z pid=304 tid=234: Booted Rails 8.0.2.1 application in production environment
2025-11-19T09:03:57.832975977Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.832Z pid=304 tid=234: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-11-19T09:03:57.832987851Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.832Z pid=304 tid=234: See LICENSE and the LGPL-3.0 for licensing details.
2025-11-19T09:03:57.832999474Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.832Z pid=304 tid=234: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-11-19T09:03:57.836154206Z 09:03:57 performance_worker.1 | INFO  2025-11-19T09:03:57.835Z pid=304 tid=234: Sidekiq 8.0.9 connecting to Redis with options {size: 1, pool_name: "default", url: nil}
2025-11-19T09:03:57.865588238Z 09:03:57 default_worker.1     | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:57.866753114Z 09:03:57 default_worker.1     | INFO  2025-11-19T09:03:57.866Z pid=303 tid=233: Sidekiq 8.0.9 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-11-19T09:03:57.927931139Z 09:03:57 default_worker.1     | INFO  2025-11-19T09:03:57.927Z pid=303 tid=233: Booted Rails 8.0.2.1 application in production environment
2025-11-19T09:03:57.927983705Z 09:03:57 default_worker.1     | INFO  2025-11-19T09:03:57.927Z pid=303 tid=233: Running in ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-11-19T09:03:57.928000679Z 09:03:57 default_worker.1     | INFO  2025-11-19T09:03:57.927Z pid=303 tid=233: See LICENSE and the LGPL-3.0 for licensing details.
2025-11-19T09:03:57.928067845Z 09:03:57 default_worker.1     | INFO  2025-11-19T09:03:57.927Z pid=303 tid=233: Upgrade to Sidekiq Pro for more features and support: https://sidekiq.org
2025-11-19T09:03:57.930155558Z 09:03:57 default_worker.1     | INFO  2025-11-19T09:03:57.929Z pid=303 tid=233: Sidekiq 8.0.9 connecting to Redis with options {size: 4, pool_name: "default", url: nil}
2025-11-19T09:03:58.018007078Z 09:03:58 rails.1              | Server: 02f5c4735d80, Context: rails, Role: web, data: {cpu: {one_min: 3.62, five_min: 2.36, fifteen_min: 2.1}, memory: 0.194748416e9, disk: {available: 840411074560, total: 938656133120, used: 98245058560}}
2025-11-19T09:03:58.018045355Z 09:03:58 rails.1              | Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:58.018077620Z 09:03:58 rails.1              | INFO  2025-11-19T09:03:57.838Z pid=302 tid=20u: Sidekiq 8.0.9 connecting to Redis with options {size: 10, pool_name: "internal", url: nil}
2025-11-19T09:03:58.018130146Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 106ca2ba-a0c0-4626-96c9-274db3f96895) 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-11-19T09:03:58.018137751Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 481b77c2-2d80-41fa-a316-62ba4cb9f28a) 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-11-19T09:03:58.018202191Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::GenerateSlugsJob (Job ID: 3a0e1af5-7c17-4392-877d-a797d812b645) 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-11-19T09:03:58.018237211Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::FixNilFileSizeValues (Job ID: 75850c15-47e5-4e3e-84c9-ad7d0dab8c22) to Sidekiq(upgrade)
2025-11-19T09:03:58.018305359Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::BackfillDataPackages (Job ID: a34e661d-5ce3-4955-8cbd-1d9a4dfc8055) to Sidekiq(upgrade)
2025-11-19T09:03:58.018333756Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::DisambiguateUsernamesJob (Job ID: c5c7f500-a07e-43e6-bc3a-afd039f643da) to Sidekiq(upgrade)
2025-11-19T09:03:58.018381231Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::UpdateActorsJob (Job ID: 0891f24e-294e-41ae-979f-1d431cfd7c50) to Sidekiq(upgrade)
2025-11-19T09:03:58.018424999Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::FixParentCollections (Job ID: 08d985e8-7971-47d9-91ed-1c4eb1efe4b6) to Sidekiq(upgrade)
2025-11-19T09:03:58.018476704Z 09:03:58 rails.1              | [ActiveJob] Enqueued Upgrade::PruneOrphanedProblems (Job ID: f8c45792-c554-4a1b-9948-d58a97c9e1df) to Sidekiq(upgrade)
2025-11-19T09:03:58.018518147Z 09:03:58 rails.1              | [302] Puma starting in cluster mode...
2025-11-19T09:03:58.018570062Z 09:03:58 rails.1              | [302] * Puma version: 7.1.0 ("Neon Witch")
2025-11-19T09:03:58.018637517Z 09:03:58 rails.1              | [302] * Ruby version: ruby 3.4.4 (2025-05-14 revision a38531fd3f) +YJIT +PRISM [x86_64-linux-musl]
2025-11-19T09:03:58.024456894Z 09:03:58 rails.1              | [302] *  Min threads: 4
2025-11-19T09:03:58.024597337Z 09:03:58 rails.1              | [302] *  Max threads: 16
2025-11-19T09:03:58.024601906Z 09:03:58 rails.1              | [302] *  Environment: production
2025-11-19T09:03:58.024659482Z 09:03:58 rails.1              | [302] *   Master PID: 302
2025-11-19T09:03:58.024710605Z 09:03:58 rails.1              | [302] *      Workers: 4
2025-11-19T09:03:58.024752469Z 09:03:58 rails.1              | [302] *     Restarts: (✔) hot (✖) phased (✖) refork
2025-11-19T09:03:58.024805887Z 09:03:58 rails.1              | [302] * Preloading application
2025-11-19T09:03:58.024856509Z 09:03:58 rails.1              | [302] * Listening on http://[::]:3214
2025-11-19T09:03:58.024903052Z 09:03:58 rails.1              | [302] Use Ctrl-C to stop
2025-11-19T09:03:58.047788770Z 09:03:58 rails.1              | [302] - Worker 0 (PID: 378) booted in 0.02s, phase: 0
2025-11-19T09:03:58.047886186Z 09:03:58 rails.1              | [302] - Worker 1 (PID: 391) booted in 0.01s, phase: 0
2025-11-19T09:03:58.047928912Z 09:03:58 rails.1              | [302] - Worker 2 (PID: 404) booted in 0.01s, phase: 0
2025-11-19T09:03:58.049522621Z 09:03:58 rails.1              | [302] - Worker 3 (PID: 417) booted in 0.0s, phase: 0
2025-11-19T09:03:58.119054907Z 09:03:58 performance_worker.1 | Server: 02f5c4735d80, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.65, five_min: 2.39, fifteen_min: 2.11}, memory: 0.241229824e9, disk: {available: 840403312640, total: 938656133120, used: 98252820480}}
2025-11-19T09:03:58.190640818Z 09:03:58 default_worker.1     | Server: 02f5c4735d80, Context: sidekiq, Role: background, data: {cpu: {one_min: 3.65, five_min: 2.39, fifteen_min: 2.11}, memory: 0.231276544e9, disk: {available: 840403312640, total: 938656133120, used: 98252820480}}
2025-11-19T09:03:58.250852018Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.250Z pid=303 tid=he7 jid=d2e6b070e896de5a01bcbe34 class=Upgrade::GenerateSlugsJob: start
2025-11-19T09:03:58.258880201Z Connection to localhost (::1) 3214 port [tcp/*] succeeded!
2025-11-19T09:03:58.260178966Z s6-rc: info: service svc-manyfold successfully started
2025-11-19T09:03:58.260480092Z s6-rc: info: service legacy-services: starting
2025-11-19T09:03:58.271376441Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [106ca2ba-a0c0-4626-96c9-274db3f96895] Performing Upgrade::GenerateSlugsJob (Job ID: 106ca2ba-a0c0-4626-96c9-274db3f96895) from Sidekiq(high) enqueued at 2025-11-19T09:03:57.864147938Z 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-11-19T09:03:58.271981720Z s6-rc: info: service legacy-services successfully started
2025-11-19T09:03:58.272139918Z s6-rc: info: service ci-service-check: starting
2025-11-19T09:03:58.272171672Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.259Z pid=303 tid=hdz jid=edc60fdfaa590c4cfe937f42 class=Upgrade::GenerateSlugsJob: start
2025-11-19T09:03:58.275776511Z [ls.io-init] done.
2025-11-19T09:03:58.276503494Z s6-rc: info: service ci-service-check successfully started
2025-11-19T09:03:58.294204533Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [481b77c2-2d80-41fa-a316-62ba4cb9f28a] Performing Upgrade::GenerateSlugsJob (Job ID: 481b77c2-2d80-41fa-a316-62ba4cb9f28a) from Sidekiq(high) enqueued at 2025-11-19T09:03:57.866984149Z 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-11-19T09:03:58.297773148Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.260Z pid=303 tid=hen jid=233703b36308879b5aaa80fc class=Upgrade::GenerateSlugsJob: start
2025-11-19T09:03:58.339228825Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [3a0e1af5-7c17-4392-877d-a797d812b645] Performing Upgrade::GenerateSlugsJob (Job ID: 3a0e1af5-7c17-4392-877d-a797d812b645) from Sidekiq(high) enqueued at 2025-11-19T09:03:57.868748742Z 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-11-19T09:03:58.340521197Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.271Z pid=303 tid=hfz jid=9625fd3aec9435285ce58c95 class=Upgrade::FixNilFileSizeValues: start
2025-11-19T09:03:58.341763398Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [75850c15-47e5-4e3e-84c9-ad7d0dab8c22] Performing Upgrade::FixNilFileSizeValues (Job ID: 75850c15-47e5-4e3e-84c9-ad7d0dab8c22) from Sidekiq(upgrade) enqueued at 2025-11-19T09:03:57.870737867Z
2025-11-19T09:03:58.347227580Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [481b77c2-2d80-41fa-a316-62ba4cb9f28a] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:58.373294783Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [3a0e1af5-7c17-4392-877d-a797d812b645] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:58.388189302Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [481b77c2-2d80-41fa-a316-62ba4cb9f28a] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-11-19T09:03:58.392892291Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [481b77c2-2d80-41fa-a316-62ba4cb9f28a] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.019
2025-11-19T09:03:58.423374013Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [75850c15-47e5-4e3e-84c9-ad7d0dab8c22] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:58.453317020Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [3a0e1af5-7c17-4392-877d-a797d812b645] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-11-19T09:03:58.472694605Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [3a0e1af5-7c17-4392-877d-a797d812b645] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.060
2025-11-19T09:03:58.603295927Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [75850c15-47e5-4e3e-84c9-ad7d0dab8c22] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-11-19T09:03:58.603647996Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [75850c15-47e5-4e3e-84c9-ad7d0dab8c22] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.111
2025-11-19T09:03:58.606069952Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [106ca2ba-a0c0-4626-96c9-274db3f96895] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:58.694030843Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [106ca2ba-a0c0-4626-96c9-274db3f96895] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-11-19T09:03:58.694340867Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [106ca2ba-a0c0-4626-96c9-274db3f96895] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.072
2025-11-19T09:03:58.732170293Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [481b77c2-2d80-41fa-a316-62ba4cb9f28a] Performed Upgrade::GenerateSlugsJob (Job ID: 481b77c2-2d80-41fa-a316-62ba4cb9f28a) from Sidekiq(high) in 442.93ms
2025-11-19T09:03:58.737295512Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [3a0e1af5-7c17-4392-877d-a797d812b645] Performed Upgrade::GenerateSlugsJob (Job ID: 3a0e1af5-7c17-4392-877d-a797d812b645) from Sidekiq(high) in 432.02ms
2025-11-19T09:03:58.741221386Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::FixNilFileSizeValues] [75850c15-47e5-4e3e-84c9-ad7d0dab8c22] Performed Upgrade::FixNilFileSizeValues (Job ID: 75850c15-47e5-4e3e-84c9-ad7d0dab8c22) from Sidekiq(upgrade) in 399.38ms
2025-11-19T09:03:58.741896786Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::GenerateSlugsJob] [106ca2ba-a0c0-4626-96c9-274db3f96895] Performed Upgrade::GenerateSlugsJob (Job ID: 106ca2ba-a0c0-4626-96c9-274db3f96895) from Sidekiq(high) in 479.99ms
2025-11-19T09:03:58.742337453Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.737Z pid=303 tid=hdz jid=edc60fdfaa590c4cfe937f42 class=Upgrade::GenerateSlugsJob elapsed=0.478: done
2025-11-19T09:03:58.742507576Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.741Z pid=303 tid=hen jid=233703b36308879b5aaa80fc class=Upgrade::GenerateSlugsJob elapsed=0.481: done
2025-11-19T09:03:58.748434449Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.748Z pid=303 tid=hdz jid=30ae32d54bad49dde169caad class=Upgrade::BackfillDataPackages: start
2025-11-19T09:03:58.750434395Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [a34e661d-5ce3-4955-8cbd-1d9a4dfc8055] Performing Upgrade::BackfillDataPackages (Job ID: a34e661d-5ce3-4955-8cbd-1d9a4dfc8055) from Sidekiq(upgrade) enqueued at 2025-11-19T09:03:57.871370691Z
2025-11-19T09:03:58.751284457Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.747Z pid=303 tid=he7 jid=d2e6b070e896de5a01bcbe34 class=Upgrade::GenerateSlugsJob elapsed=0.497: done
2025-11-19T09:03:58.751389478Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.741Z pid=303 tid=hfz jid=9625fd3aec9435285ce58c95 class=Upgrade::FixNilFileSizeValues elapsed=0.471: done
2025-11-19T09:03:58.751979987Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.751Z pid=303 tid=he7 jid=9a502d115c92c06e1f000542 class=Upgrade::UpdateActorsJob: start
2025-11-19T09:03:58.753247279Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [0891f24e-294e-41ae-979f-1d431cfd7c50] Performing Upgrade::UpdateActorsJob (Job ID: 0891f24e-294e-41ae-979f-1d431cfd7c50) from Sidekiq(upgrade) enqueued at 2025-11-19T09:03:57.872671920Z
2025-11-19T09:03:58.758271705Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.750Z pid=303 tid=hen jid=3a8ad7bd3a69d0c1a2d656c9 class=Upgrade::DisambiguateUsernamesJob: start
2025-11-19T09:03:58.758826702Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [a34e661d-5ce3-4955-8cbd-1d9a4dfc8055] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:58.815738348Z 09:03:58 default_worker.1     | INFO  2025-11-19T09:03:58.752Z pid=303 tid=hfz jid=eb78ed298d732e3dc67ff1fc class=Upgrade::FixParentCollections: start
2025-11-19T09:03:58.885406929Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [c5c7f500-a07e-43e6-bc3a-afd039f643da] Performing Upgrade::DisambiguateUsernamesJob (Job ID: c5c7f500-a07e-43e6-bc3a-afd039f643da) from Sidekiq(upgrade) enqueued at 2025-11-19T09:03:57.872058876Z
2025-11-19T09:03:58.890531456Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [08d985e8-7971-47d9-91ed-1c4eb1efe4b6] Performing Upgrade::FixParentCollections (Job ID: 08d985e8-7971-47d9-91ed-1c4eb1efe4b6) from Sidekiq(upgrade) enqueued at 2025-11-19T09:03:57.873252209Z
2025-11-19T09:03:58.994857957Z 09:03:58 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [0891f24e-294e-41ae-979f-1d431cfd7c50] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:59.040801229Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [c5c7f500-a07e-43e6-bc3a-afd039f643da] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:59.050651903Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [08d985e8-7971-47d9-91ed-1c4eb1efe4b6] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:59.148712317Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::BackfillDataPackages] [a34e661d-5ce3-4955-8cbd-1d9a4dfc8055] Performed Upgrade::BackfillDataPackages (Job ID: a34e661d-5ce3-4955-8cbd-1d9a4dfc8055) from Sidekiq(upgrade) in 399.67ms
2025-11-19T09:03:59.173152084Z 09:03:59 default_worker.1     | INFO  2025-11-19T09:03:59.172Z pid=303 tid=hdz jid=30ae32d54bad49dde169caad class=Upgrade::BackfillDataPackages elapsed=0.423: done
2025-11-19T09:03:59.176700739Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::UpdateActorsJob] [0891f24e-294e-41ae-979f-1d431cfd7c50] Performed Upgrade::UpdateActorsJob (Job ID: 0891f24e-294e-41ae-979f-1d431cfd7c50) from Sidekiq(upgrade) in 420.22ms
2025-11-19T09:03:59.177040874Z 09:03:59 default_worker.1     | INFO  2025-11-19T09:03:59.176Z pid=303 tid=hdz jid=c685dd9ea518e2303cf5e976 class=Upgrade::PruneOrphanedProblems: start
2025-11-19T09:03:59.194362469Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::FixParentCollections] [08d985e8-7971-47d9-91ed-1c4eb1efe4b6] Performed Upgrade::FixParentCollections (Job ID: 08d985e8-7971-47d9-91ed-1c4eb1efe4b6) from Sidekiq(upgrade) in 316.44ms
2025-11-19T09:03:59.200736473Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::DisambiguateUsernamesJob] [c5c7f500-a07e-43e6-bc3a-afd039f643da] Performed Upgrade::DisambiguateUsernamesJob (Job ID: c5c7f500-a07e-43e6-bc3a-afd039f643da) from Sidekiq(upgrade) in 441.99ms
2025-11-19T09:03:59.204735614Z 09:03:59 default_worker.1     | INFO  2025-11-19T09:03:59.200Z pid=303 tid=he7 jid=9a502d115c92c06e1f000542 class=Upgrade::UpdateActorsJob elapsed=0.448: done
2025-11-19T09:03:59.204901819Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f8c45792-c554-4a1b-9948-d58a97c9e1df] Performing Upgrade::PruneOrphanedProblems (Job ID: f8c45792-c554-4a1b-9948-d58a97c9e1df) from Sidekiq(upgrade) enqueued at 2025-11-19T09:03:57.874048462Z
2025-11-19T09:03:59.205544603Z 09:03:59 default_worker.1     | INFO  2025-11-19T09:03:59.204Z pid=303 tid=hfz jid=eb78ed298d732e3dc67ff1fc class=Upgrade::FixParentCollections elapsed=0.452: done
2025-11-19T09:03:59.205601968Z 09:03:59 default_worker.1     | INFO  2025-11-19T09:03:59.204Z pid=303 tid=hen jid=3a8ad7bd3a69d0c1a2d656c9 class=Upgrade::DisambiguateUsernamesJob elapsed=0.455: done
2025-11-19T09:03:59.208402056Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f8c45792-c554-4a1b-9948-d58a97c9e1df] Scoped order is ignored, use :cursor with :order to configure custom order.
2025-11-19T09:03:59.339607926Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f8c45792-c554-4a1b-9948-d58a97c9e1df] [JobIteration::Iteration] Enumerator found nothing to iterate! times_interrupted=0 cursor_position=
2025-11-19T09:03:59.341761251Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f8c45792-c554-4a1b-9948-d58a97c9e1df] [JobIteration::Iteration] Completed iterating. times_interrupted=0 total_time=0.119
2025-11-19T09:03:59.359747555Z 09:03:59 default_worker.1     | [ActiveJob] [Upgrade::PruneOrphanedProblems] [f8c45792-c554-4a1b-9948-d58a97c9e1df] Performed Upgrade::PruneOrphanedProblems (Job ID: f8c45792-c554-4a1b-9948-d58a97c9e1df) from Sidekiq(upgrade) in 164.14ms
2025-11-19T09:03:59.361443830Z 09:03:59 default_worker.1     | INFO  2025-11-19T09:03:59.360Z pid=303 tid=hdz jid=c685dd9ea518e2303cf5e976 class=Upgrade::PruneOrphanedProblems elapsed=0.184: done
2025-11-19T09:03:59.463830776Z 09:03:59 rails.1              | [39e7cff8-3303-4a6b-af2f-71a014123524] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":0,"allocations":1394,"duration":17.24,"view":0.0,"db":2.18,"@timestamp":"2025-11-19T09:03:59.462Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-11-19T09:04:00.411176740Z 09:04:00 rails.1              | [ef80ef85-ab78-4935-bcad-53e771e6f7a7] {"method":"GET","path":"/users/sign_in","format":"*/*","controller":"Users::SessionsController","action":"new","status":302,"allocations":173752,"duration":928.9,"view":0.0,"db":28.06,"location":"http://172.17.0.4:3214/","@timestamp":"2025-11-19T09:04:00.410Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-11-19T09:04:00.491563671Z 09:04:00 rails.1              | [15ec2f3f-6981-4d50-a9f4-8a65d949e88a] {"method":"GET","path":"/","format":"*/*","controller":"HomeController","action":"index","status":302,"allocations":1089,"duration":52.05,"view":0.0,"db":3.39,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-11-19T09:04:00.473Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-11-19T09:04:01.318842522Z 09:04:01 rails.1              | [f8097bb2-61e6-41bf-b30f-538f08dff4d0] {"method":"GET","path":"/users/edit","format":"*/*","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":26133,"duration":787.93,"view":636.32,"db":68.56,"@timestamp":"2025-11-19T09:04:01.317Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}
2025-11-19T09:04:01.396300756Z 09:04:01 rails.1              | [10092b1f-d155-4fab-bac0-3a5eb1212c81] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":0,"allocations":1180,"duration":32.46,"view":0.0,"db":3.96,"@timestamp":"2025-11-19T09:04:01.394Z","@version":"1","message":"[0] GET / (HomeController#index)"}
2025-11-19T09:04:01.730042370Z 09:04:01 rails.1              | [f9be6954-f820-47c9-8fb8-22dffa62876f] {"method":"GET","path":"/users/sign_in","format":"html","controller":"Users::SessionsController","action":"new","status":302,"allocations":15473,"duration":214.8,"view":0.0,"db":1.77,"location":"http://172.17.0.4:3214/","@timestamp":"2025-11-19T09:04:01.693Z","@version":"1","message":"[302] GET /users/sign_in (Users::SessionsController#new)"}
2025-11-19T09:04:01.769212084Z 09:04:01 rails.1              | [1678728e-ff3b-4444-8ea4-6c135cacadd1] {"method":"GET","path":"/","format":"html","controller":"HomeController","action":"index","status":302,"allocations":1138,"duration":31.49,"view":0.0,"db":2.83,"location":"http://172.17.0.4:3214/users/edit","@timestamp":"2025-11-19T09:04:01.768Z","@version":"1","message":"[302] GET / (HomeController#index)"}
2025-11-19T09:04:02.165565642Z 09:04:02 rails.1              | [154dec4e-db04-40aa-80ce-ef5558ce7c45] {"method":"GET","path":"/users/edit","format":"html","controller":"Users::RegistrationsController","action":"edit","status":200,"allocations":26340,"duration":369.22,"view":236.53,"db":1.69,"@timestamp":"2025-11-19T09:04:02.160Z","@version":"1","message":"[200] GET /users/edit (Users::RegistrationsController#edit)"}