On localhost, PageTriage PHP unit tests pass on MariaDB
but have 8 errors and 2 failures on SQLite
Likely root cause: T339132: PageTriage: cleanup dangling test database danglers and remove defensive code in test cases
Steps to reproduce:
- MediaWiki docker: https://github.com/wikimedia/mediawiki/blob/master/DEVELOPERS.md
- don't deviate from the above tutorial at all. this will give you the default database backend SQLite, which is the problematic database backend in this ticket
- install PageTriage extension
- docker compose exec mediawiki php tests/phpunit/phpunit.php --filter PageTriage
Error logs:
PS F:\Dropbox\Code\mediawiki-docker\mediawiki> docker compose exec mediawiki php tests/phpunit/phpunit.php --filter PageTriage
time="2023-07-10T14:34:31-07:00" level=warning msg="The \"MW_DOCKER_UID\" variable is not set. Defaulting to a blank string."
time="2023-07-10T14:34:31-07:00" level=warning msg="The \"MW_DOCKER_GID\" variable is not set. Defaulting to a blank string."
time="2023-07-10T14:34:31-07:00" level=warning msg="The \"MW_DOCKER_UID\" variable is not set. Defaulting to a blank string."
time="2023-07-10T14:34:31-07:00" level=warning msg="The \"MW_DOCKER_GID\" variable is not set. Defaulting to a blank string."
time="2023-07-10T14:34:31-07:00" level=warning msg="The \"MW_DOCKER_UID\" variable is not set. Defaulting to a blank string."
time="2023-07-10T14:34:31-07:00" level=warning msg="The \"MW_DOCKER_GID\" variable is not set. Defaulting to a blank string."
Using PHP 8.1.13
PHPUnit 9.5.28 by Sebastian Bergmann and contributors.
............................................................... 63 / 261 ( 24%)
............................................................... 126 / 261 ( 48%)
............................................................... 189 / 261 ( 72%)
EEE......SSS.E....E...S...FS.........E.F.EE...............S.... 252 / 261 ( 96%)
...S..... 261 / 261 (100%)
Time: 02:25.173, Memory: 332.00 MB
There were 8 errors:
1) MediaWiki\Extension\PageTriage\Test\ApiPageTriageListTest::testAfcTags
Undefined array key "afc_state"
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:506
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:349
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:36
/var/www/html/w/includes/api/ApiMain.php:1915
/var/www/html/w/includes/api/ApiMain.php:861
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:124
/var/www/html/w/extensions/PageTriage/tests/phpunit/PageTriageTestCase.php:97
/var/www/html/w/extensions/PageTriage/tests/phpunit/ApiPageTriageListTest.php:67
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #129291 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #129291, processing time: 0.0023670196533203 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:ca97fdddc1024a4fddebcbfdbec036e97f733af5): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:my_wiki-unittest_","lag":0,"age":0.03922700881958008,"walltime":0.006646871566772461}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:my_wiki-unittest_","lag":0,"age":0.05478310585021973,"walltime":0.006350040435791016}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #129603 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #129603, processing time: 0.036615133285522 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #129598 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #129598, processing time: 0.0063490867614746 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129594 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:2-0!canonical!en","cache_time":"20230710213644","rev_id":2}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"my_wiki-unittest_:page:118:ca97fdddc1024a4fddebcbfdbec036e97f733af5","lag":0,"age":0.035639047622680664,"walltime":0.0071179866790771484}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:ca97fdddc1024a4fddebcbfdbec036e97f733af5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129594, processing time: 0.095826864242554 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #129598 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns118%3AAfC_test_page:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #129598, processing time: 0.11290097236633 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129603 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129603, processing time: 0.0001530647277832 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #129542 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #129542, processing time: 0.014521837234497 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129693 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129693, processing time: 0.00019216537475586 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #129694 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #129694, processing time: 0.037649869918823 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129619 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129619, processing time: 0.093251943588257 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #129641 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Draft:AfC_test_page http://localhost:8080/w/index.php?title=Draft:AfC_test_page&action=history http://localhost:8080/wiki/Draft_talk:AfC_test_page http://localhost:8080/w/index.php?title=Draft_talk:AfC_test_page&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #129641, processing time: 0.0027461051940918 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129608 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129608, processing time: 0.0061278343200684 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
===
2) MediaWiki\Extension\PageTriage\Test\ApiPageTriageListTest::testMultiAfcCategories
Undefined array key "afc_state"
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:506
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:349
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:36
/var/www/html/w/includes/api/ApiMain.php:1915
/var/www/html/w/includes/api/ApiMain.php:861
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:124
/var/www/html/w/extensions/PageTriage/tests/phpunit/PageTriageTestCase.php:97
/var/www/html/w/extensions/PageTriage/tests/phpunit/ApiPageTriageListTest.php:110
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #130299 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #130299, processing time: 0.002316951751709 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:ca97fdddc1024a4fddebcbfdbec036e97f733af5): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:my_wiki-unittest_","lag":0,"age":0.03959989547729492,"walltime":0.006005048751831055}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:my_wiki-unittest_","lag":0,"age":0.05369997024536133,"walltime":0.0063610076904296875}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #130611 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #130611, processing time: 0.022867918014526 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #130606 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #130606, processing time: 0.0066709518432617 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #130602 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:2-0!canonical!en","cache_time":"20230710213646","rev_id":2}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"my_wiki-unittest_:page:118:ca97fdddc1024a4fddebcbfdbec036e97f733af5","lag":0,"age":0.03176593780517578,"walltime":0.00528407096862793}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:ca97fdddc1024a4fddebcbfdbec036e97f733af5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #130602, processing time: 0.086925029754639 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #130606 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:14:97df6c94db2c5dea3ea1702d3ffef4ac9d14ba00): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:14:11a586337704ce71dd3a170abf2057a3768dfbf5): miss, new value computed []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns118%3AAfC_test_page:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:118%3AAfC_test_page): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #130606, processing time: 0.26858592033386 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #130611 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #130611, processing time: 0.00016093254089355 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #130550 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #130550, processing time: 0.013860940933228 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #130703 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #130703, processing time: 0.0029280185699463 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #130705 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #130705, processing time: 0.00020194053649902 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #130709 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #130709, processing time: 0.023905038833618 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #130654 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #130654, processing time: 0.10748791694641 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #130651 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Draft:AfC_test_page http://localhost:8080/w/index.php?title=Draft:AfC_test_page&action=history http://localhost:8080/wiki/Draft_talk:AfC_test_page http://localhost:8080/w/index.php?title=Draft_talk:AfC_test_page&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #130651, processing time: 0.0026431083679199 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #130616 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #130616, processing time: 0.0074028968811035 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
===
3) MediaWiki\Extension\PageTriage\Test\ApiPageTriageListTest::testUnsubmittedDrafts
Undefined array key "afc_state"
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:506
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:349
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:36
/var/www/html/w/includes/api/ApiMain.php:1915
/var/www/html/w/includes/api/ApiMain.php:861
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:124
/var/www/html/w/extensions/PageTriage/tests/phpunit/PageTriageTestCase.php:97
/var/www/html/w/extensions/PageTriage/tests/phpunit/ApiPageTriageListTest.php:133
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #131309 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #131309, processing time: 0.0039539337158203 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
===
4) MediaWiki\Extension\PageTriage\Test\ApiPageTriageListTest::testFilterType
Undefined array key "recreated"
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:509
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:349
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:36
/var/www/html/w/includes/api/ApiMain.php:1915
/var/www/html/w/includes/api/ApiMain.php:861
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:124
/var/www/html/w/extensions/PageTriage/tests/phpunit/PageTriageTestCase.php:97
/var/www/html/w/extensions/PageTriage/tests/phpunit/ApiPageTriageListTest.php:575
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #143723 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #143723, processing time: 0.0026469230651855 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[UserOptionsManager] [debug] Loading options from database {"user_id":25}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:my_wiki-unittest_","lag":0,"age":0.03314709663391113,"walltime":0.006031990051269531}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:my_wiki-unittest_","lag":0,"age":0.04725790023803711,"walltime":0.0061190128326416016}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #144026 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #144026, processing time: 0.023744106292725 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #144021 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #144021, processing time: 0.0063998699188232 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144017 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:2-0!canonical!en","cache_time":"20230710213712","rev_id":2}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageOther): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for TestUser bcba33.042 {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144017, processing time: 0.10442399978638 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #144021 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageOther): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns0%3APageOther:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageOther): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #144021, processing time: 0.11507987976074 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144026 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144026, processing time: 0.00026798248291016 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #143984 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #143984, processing time: 0.013388872146606 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144181 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144181, processing time: 0.00019097328186035 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #144182 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #144182, processing time: 0.022692203521729 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144042 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144042, processing time: 0.097862005233765 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #144068 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/PageOther http://localhost:8080/w/index.php?title=PageOther&action=history http://localhost:8080/wiki/Talk:PageOther http://localhost:8080/w/index.php?title=Talk:PageOther&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #144068, processing time: 0.0027229785919189 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144031 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144031, processing time: 0.0061659812927246 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #144214 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #144214, processing time: 0.038091897964478 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #144215 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #144215, processing time: 0.0060160160064697 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144228 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:3-0!canonical!en","cache_time":"20230710213713","rev_id":3}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageDel): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144228, processing time: 0.072197914123535 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #144215 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:14:f101fef8cfe637832fae2eb051208a23f5bea4e5): miss, new value computed []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageDel): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns0%3APageDel:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageDel): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #144215, processing time: 0.18603706359863 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144214 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144214, processing time: 0.00018787384033203 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #144224 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #144224, processing time: 0.014625072479248 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #144249 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #144249, processing time: 0.0029489994049072 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144284 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144284, processing time: 0.00021195411682129 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #144141 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #144141, processing time: 0.020603895187378 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144304 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144304, processing time: 0.08544397354126 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #144242 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/PageDel http://localhost:8080/w/index.php?title=PageDel&action=history http://localhost:8080/wiki/Talk:PageDel http://localhost:8080/w/index.php?title=Talk:PageDel&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #144242, processing time: 0.002791166305542 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144210 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144210, processing time: 0.0059981346130371 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #144321 []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:change_tag_def:my_wiki-unittest_","lag":0,"age":0.020539045333862305,"walltime":0.005825042724609375}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:change_tag_def:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #144321, processing time: 0.047657012939453 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #144312 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #144312, processing time: 0.0057189464569092 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144324 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213713","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageRedir): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144324, processing time: 0.079168081283569 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #144312 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageRedir): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"my_wiki-unittest_:numbacklinks:ns0%3APageRedir:templatelinks","lag":0,"age":0.0644068717956543,"walltime":0.01996898651123047}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns0%3APageRedir:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageRedir): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #144312, processing time: 0.12579894065857 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144321 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144321, processing time: 0.00017595291137695 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #144307 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #144307, processing time: 0.014513969421387 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144376 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144376, processing time: 0.00020408630371094 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #144180 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #144180, processing time: 0.024255037307739 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144292 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144292, processing time: 0.11230397224426 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #144320 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/PageRedir http://localhost:8080/w/index.php?title=PageRedir&action=history http://localhost:8080/wiki/Talk:PageRedir http://localhost:8080/w/index.php?title=Talk:PageRedir&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #144320, processing time: 0.0038459300994873 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144311 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144311, processing time: 0.0049469470977783 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #144405 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #144405, processing time: 0.025261878967285 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #144406 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #144406, processing time: 0.0073690414428711 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144401 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:5-0!canonical!en","cache_time":"20230710213714","rev_id":5}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageRfD): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #144401, processing time: 0.070827007293701 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #144406 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:14:ad15edaa48483972497f05be926385880cae058b): miss, new value computed []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageRfD): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns0%3APageRfD:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageRfD): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #144406, processing time: 0.18115615844727 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144405 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #144405, processing time: 0.0002138614654541 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #144415 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #144415, processing time: 0.014527082443237 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #144433 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #144433, processing time: 0.0039029121398926 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144469 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #144469, processing time: 0.00018215179443359 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #144319 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #144319, processing time: 0.020256996154785 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144489 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #144489, processing time: 0.085052967071533 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #144380 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/PageRfD http://localhost:8080/w/index.php?title=PageRfD&action=history http://localhost:8080/wiki/Talk:PageRfD http://localhost:8080/w/index.php?title=Talk:PageRfD&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #144380, processing time: 0.0022170543670654 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144403 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #144403, processing time: 0.0042388439178467 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A43): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144840 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144840, processing time: 0.032113075256348 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213715","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144621 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144621, processing time: 0.03168797492981 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A41): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144898 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144898, processing time: 0.039664030075073 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A40): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144829 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144829, processing time: 0.038716077804565 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:2): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A40): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #125071 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #125071, processing time: 0.034635066986084 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:2): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A43): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #128521 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #128521, processing time: 0.034271955490112 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A41): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #128546 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #128546, processing time: 0.036288022994995 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:3): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A43): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #130507 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #130507, processing time: 0.036374807357788 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A41): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #131075 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #131075, processing time: 0.035833835601807 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A40): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #130748 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #130748, processing time: 0.035906076431274 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:2): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213717","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #132828 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #132828, processing time: 0.03795599937439 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:4): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213718","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #139023 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #139023, processing time: 0.036241054534912 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A40): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #139041 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #139041, processing time: 0.035825967788696 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:2): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A43): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #125729 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #125729, processing time: 0.034751892089844 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213719","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #126603 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #126603, processing time: 0.040199995040894 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A41): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #125978 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #125978, processing time: 0.036518096923828 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:3): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[ParserCache] [debug] Creating ParserCache instance for pcache []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A43): miss, new value computed []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144111 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144111, processing time: 0.039921045303345 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213719","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A42): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #127011 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #127011, processing time: 0.0400710105896 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A41): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #143827 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #143827, processing time: 0.038264036178589 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A40): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144122 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\ArticleCompile\ArticleCompileProcessor->compileMetadata #144122, processing time: 0.041845798492432 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:2): miss, new value computed []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[objectcache] [debug] getWithSetCallback(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A40): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_ManualLogEntry->publish #143827 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_ManualLogEntry->publish #143827, processing time: 0.046408891677856 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #144108 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #144108, processing time: 0.0065381526947021 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MediaWiki\Deferred\LinksUpdate\LinksDeletionUpdate #144108 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MediaWiki\Deferred\LinksUpdate\LinksDeletionUpdate #144108, processing time: 0.077510118484497 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #128649 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #128649, processing time: 0.00024986267089844 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129333 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129333, processing time: 0.10616993904114 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageOther): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns0%3APageOther:templatelinks): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #129333 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/PageOther http://localhost:8080/w/index.php?title=PageOther&action=history http://localhost:8080/wiki/Talk:PageOther http://localhost:8080/w/index.php?title=Talk:PageOther&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #129333, processing time: 0.0037589073181152 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #129597 []
[search] [debug] Skipping update: search updates disabled by config []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #129597, processing time: 0.0029478073120117 []
[UserOptionsManager] [debug] Loading options from database {"user_id":25}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #129390 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #129390, processing time: 0.05014705657959 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #129391 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #129391, processing time: 0.019217014312744 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129409 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:6-0!canonical!en","cache_time":"20230710213721","rev_id":6}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:6:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageOther): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for TestUser bcba33.042 {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129409, processing time: 0.094667196273804 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #129391 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3APageOther): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #129391, processing time: 0.10591220855713 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129390 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129390, processing time: 0.00029301643371582 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #129398 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #129398, processing time: 0.015125036239624 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129312 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129312, processing time: 0.00029182434082031 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #129346 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #129346, processing time: 0.023022890090942 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129393 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129393, processing time: 0.090823173522949 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #129405 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/PageOther http://localhost:8080/w/index.php?title=PageOther&action=history http://localhost:8080/wiki/Talk:PageOther http://localhost:8080/w/index.php?title=Talk:PageOther&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #129405, processing time: 0.0038681030273438 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129388 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129388, processing time: 0.0092000961303711 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
===
5) MediaWiki\Extension\PageTriage\Test\ApiPageTriageStatsTest::testApiParamsByEndpoint
Undefined array key "recreated"
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:509
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageList.php:349
/var/www/html/w/extensions/PageTriage/includes/PageTriageUtil.php:169
/var/www/html/w/extensions/PageTriage/includes/Api/ApiPageTriageStats.php:24
/var/www/html/w/includes/api/ApiMain.php:1915
/var/www/html/w/includes/api/ApiMain.php:861
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:124
/var/www/html/w/extensions/PageTriage/tests/phpunit/ApiPageTriageStatsTest.php:57
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #140439 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #140439, processing time: 0.0027270317077637 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-unreviewed-articles-stat:0): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-unreviewed-redirects-stat:0): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-reviewed-articles-stat:0): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-reviewed-redirects-stat:0): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
===
6) MediaWiki\Extension\PageTriage\Test\MaintenanceDeleteAfcStatesTest::testSuccessfulDeleteAfcStates
Undefined array key "afc_state"
/var/www/html/w/extensions/PageTriage/tests/phpunit/MaintenanceDeleteAfcStatesTest.php:38
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #121425 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #121425, processing time: 0.0026950836181641 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3AMainTest1): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:my_wiki-unittest_","lag":0,"age":0.03462409973144531,"walltime":0.006551980972290039}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:my_wiki-unittest_","lag":0,"age":0.04829001426696777,"walltime":0.0048999786376953125}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #142296 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #142296, processing time: 0.026701927185059 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #120701 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #120701, processing time: 0.0052919387817383 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #120974 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:13-0!canonical!en","cache_time":"20230710213803","rev_id":13}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:13): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:13:13): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3AMainTest1): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #120974, processing time: 0.10193300247192 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #120701 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:14:f101fef8cfe637832fae2eb051208a23f5bea4e5): miss, new value computed []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3AMainTest1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns0%3AMainTest1:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3AMainTest1): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #120701, processing time: 0.36536502838135 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #142296 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #142296, processing time: 0.00020694732666016 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #142255 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #142255, processing time: 0.014225959777832 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #142379 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #142379, processing time: 0.003666877746582 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #142196 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #142196, processing time: 0.00018620491027832 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #142434 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #142434, processing time: 0.023720979690552 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #120698 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #120698, processing time: 0.091209888458252 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #120604 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/MainTest1 http://localhost:8080/w/index.php?title=MainTest1&action=history http://localhost:8080/wiki/Talk:MainTest1 http://localhost:8080/w/index.php?title=Talk:MainTest1&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #120604, processing time: 0.0040750503540039 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #120670 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #120670, processing time: 0.0060930252075195 []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A75): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:13): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
===
7) MediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTest::testPreExistingPageAddedToDraftQueueAfterActivation
Undefined array key "afc_state"
/var/www/html/w/extensions/PageTriage/includes/Maintenance/PopulateDraftQueue.php:35
/var/www/html/w/extensions/PageTriage/tests/phpunit/MaintenancePopulateDraftQueueTest.php:48
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #144363 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #144363, processing time: 0.0028538703918457 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:553642f6367fdf1104eb17dda17f549b81939aaa): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTest1): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:my_wiki-unittest_","lag":0,"age":0.03382992744445801,"walltime":0.005593061447143555}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:my_wiki-unittest_","lag":0,"age":0.04817986488342285,"walltime":0.005290031433105469}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #132421 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #132421, processing time: 0.025623083114624 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #136786 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #136786, processing time: 0.0053350925445557 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #136762 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:15-0!canonical!en","cache_time":"20230710213806","rev_id":15}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:15): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:15): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #136762, processing time: 0.039561986923218 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #136786 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTest1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTest1:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTest1): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #136786, processing time: 0.11444687843323 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #132421 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #132421, processing time: 0.00021004676818848 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #133391 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #133391, processing time: 0.014097929000854 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #137187 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #137187, processing time: 0.00031304359436035 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #130028 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #130028, processing time: 0.021345853805542 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #131229 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTest1 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTest1&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #131229, processing time: 0.0029001235961914 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #132202 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #132202, processing time: 0.0058879852294922 []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
===
8) MediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTest::testPreExistingPagesWithCategoriesAreGivenCorrectTags
Undefined array key "afc_state"
/var/www/html/w/extensions/PageTriage/includes/Maintenance/PopulateDraftQueue.php:35
/var/www/html/w/extensions/PageTriage/tests/phpunit/MaintenancePopulateDraftQueueTest.php:97
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #122130 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #122130, processing time: 0.0026640892028809 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:b2e4f9d34b15f22f539f5f8f8a2caa8f1acb9fd9): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest1): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:my_wiki-unittest_","lag":0,"age":0.0356748104095459,"walltime":0.0053098201751708984}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:my_wiki-unittest_","lag":0,"age":0.04928398132324219,"walltime":0.004897117614746094}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145198 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145198, processing time: 0.024483203887939 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145193 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145193, processing time: 0.0067539215087891 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145189 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:2-0!canonical!en","cache_time":"20230710213807","rev_id":2}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145189, processing time: 0.036402940750122 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145193 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:14:97df6c94db2c5dea3ea1702d3ffef4ac9d14ba00): miss, new value computed []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest1:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest1): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145193, processing time: 0.18429684638977 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145198 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145198, processing time: 0.00016593933105469 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145137 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145137, processing time: 0.013549089431763 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #145285 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #145285, processing time: 0.0040838718414307 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145287 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145287, processing time: 0.00019693374633789 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145307 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145307, processing time: 0.024004220962524 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145236 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest1 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest1&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145236, processing time: 0.0027129650115967 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145203 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145203, processing time: 0.0060610771179199 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:79180010dddf27f85d36aa7d81fe080b46aa7a82): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest2): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145327 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145327, processing time: 0.024030923843384 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145326 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145326, processing time: 0.0048239231109619 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145312 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:3-0!canonical!en","cache_time":"20230710213808","rev_id":3}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145312, processing time: 0.031781911849976 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145326 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest2:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest2): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145326, processing time: 0.11313796043396 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145327 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145327, processing time: 0.0001528263092041 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145319 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145319, processing time: 0.014213085174561 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145381 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145381, processing time: 0.00016403198242188 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145247 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145247, processing time: 0.025192975997925 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145198 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest2 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest2&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145198, processing time: 0.0041680335998535 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145329 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145329, processing time: 0.0058491230010986 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:3db568a8134e894e8d7be39455eaac33c36c9e61): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest3): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145410 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145410, processing time: 0.025182962417603 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145409 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145409, processing time: 0.0048539638519287 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145386 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213808","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145386, processing time: 0.031310081481934 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145409 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest3:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest3): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145409, processing time: 0.18051195144653 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145410 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145410, processing time: 0.00027704238891602 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145402 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145402, processing time: 0.016417026519775 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #145460 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #145460, processing time: 0.0041139125823975 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145462 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145462, processing time: 0.00020003318786621 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145346 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145346, processing time: 0.025101900100708 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145360 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest3 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest3&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145360, processing time: 0.0029909610748291 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145412 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145412, processing time: 0.0069999694824219 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:3b6abb4a003b662712f3ea5562f6b1fe6fdc520a): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest4): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145491 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145491, processing time: 0.022407054901123 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145490 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145490, processing time: 0.0064671039581299 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145476 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:5-0!canonical!en","cache_time":"20230710213809","rev_id":5}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145476, processing time: 0.032676935195923 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145490 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest4:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest4): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145490, processing time: 0.11631679534912 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145491 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145491, processing time: 0.0002288818359375 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145483 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145483, processing time: 0.028524160385132 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145543 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145543, processing time: 0.00015401840209961 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145431 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145431, processing time: 0.021638154983521 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145410 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest4 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest4&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145410, processing time: 0.0029349327087402 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145493 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145493, processing time: 0.0057060718536377 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:de31c3923fea39e13e7d72f79c30a778cb2f2599): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest5): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145572 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145572, processing time: 0.023008108139038 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145571 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145571, processing time: 0.0060150623321533 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145548 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:6-0!canonical!en","cache_time":"20230710213809","rev_id":6}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145548, processing time: 0.033070087432861 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145571 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest5:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest5): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145571, processing time: 0.16048002243042 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145572 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145572, processing time: 0.00014901161193848 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145564 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145564, processing time: 0.014279127120972 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #145622 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #145622, processing time: 0.0031290054321289 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145624 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145624, processing time: 0.00013399124145508 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145508 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145508, processing time: 0.021920919418335 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145550 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest5 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest5&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145550, processing time: 0.0025269985198975 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145574 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145574, processing time: 0.0066099166870117 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:e212ba4519b5ca02d8b87f65d5c7dbe344d06dc2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest6): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145653 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145653, processing time: 0.021494150161743 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145652 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145652, processing time: 0.0058908462524414 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145638 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:7-0!canonical!en","cache_time":"20230710213810","rev_id":7}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145638, processing time: 0.03207802772522 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145652 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest6:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest6): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145652, processing time: 0.13749814033508 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145653 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145653, processing time: 0.00024008750915527 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145645 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145645, processing time: 0.018471956253052 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145705 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145705, processing time: 0.00018310546875 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145593 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145593, processing time: 0.027719974517822 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145572 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest6 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest6&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145572, processing time: 0.00412917137146 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145655 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145655, processing time: 0.0051050186157227 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:9ba69b4be7538058b60baa383b91555966927598): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest7): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145734 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145734, processing time: 0.027776956558228 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145733 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145733, processing time: 0.0073471069335938 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145710 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:8-0!canonical!en","cache_time":"20230710213810","rev_id":8}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:8): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:8): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145710, processing time: 0.032449960708618 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145733 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest7): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\\Extension\\PageTriage\\Test\\MaintenancePopulateDraftQueueTestTagTest7:templatelinks","lag":0,"age":0.06853008270263672,"walltime":0.02159905433654785}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest7:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest7): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145733, processing time: 0.17703080177307 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145734 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145734, processing time: 0.0001671314239502 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145726 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145726, processing time: 0.015462875366211 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #145784 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #145784, processing time: 0.00347900390625 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145786 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145786, processing time: 0.0001990795135498 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145670 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145670, processing time: 0.026381969451904 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145684 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest7 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest7&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145684, processing time: 0.0041189193725586 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145736 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145736, processing time: 0.0070309638977051 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:2931d4d8f1a2bfb887d63cc3d2c09f44a6ee4f10): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest8): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145815 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145815, processing time: 0.026937007904053 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145814 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145814, processing time: 0.0056028366088867 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145799 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:9-0!canonical!en","cache_time":"20230710213811","rev_id":9}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:9): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:9): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145799, processing time: 0.036914110183716 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145814 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest8): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest8:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest8): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145814, processing time: 0.12866806983948 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145815 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145815, processing time: 0.00017595291137695 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145807 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145807, processing time: 0.015581130981445 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145867 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145867, processing time: 0.00021696090698242 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145755 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145755, processing time: 0.026259183883667 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145792 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest8 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest8&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145792, processing time: 0.0039870738983154 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145817 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145817, processing time: 0.0060830116271973 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:b4304c7600723676478e77e239db5b014e4b9ff1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest9): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145896 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145896, processing time: 0.02313494682312 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145895 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145895, processing time: 0.005763053894043 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145872 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:10-0!canonical!en","cache_time":"20230710213811","rev_id":10}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:10): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:10): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145872, processing time: 0.037402868270874 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145895 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest9): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest9:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest9): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145895, processing time: 0.19475483894348 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145896 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145896, processing time: 0.00025200843811035 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145888 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145888, processing time: 0.020146131515503 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #145946 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #145946, processing time: 0.003925085067749 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145948 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #145948, processing time: 0.00020408630371094 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145794 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145794, processing time: 0.027040958404541 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145846 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest9 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest9&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145846, processing time: 0.003993034362793 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145898 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145898, processing time: 0.0052711963653564 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:aaedd272adaac7db9b974b5e9b41d02c1e70671d): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest10): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #145977 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #145977, processing time: 0.025968790054321 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #145976 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #145976, processing time: 0.0058960914611816 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145962 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:11-0!canonical!en","cache_time":"20230710213812","rev_id":11}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:11): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:11): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #145962, processing time: 0.038099050521851 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #145976 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest10): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest10:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestTagTest10): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #145976, processing time: 0.14688086509705 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145977 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #145977, processing time: 0.00017094612121582 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #145969 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #145969, processing time: 0.017419099807739 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #146029 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #146029, processing time: 0.00017905235290527 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145917 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145917, processing time: 0.028527021408081 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #145896 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest10 http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestTagTest10&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #145896, processing time: 0.003446102142334 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145979 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #145979, processing time: 0.0064420700073242 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:210:1c5986e871ed3b703164fc6b14ff490f803862b8): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestRedirectTest): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #146043 []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:change_tag_def:my_wiki-unittest_","lag":0,"age":0.02354907989501953,"walltime":0.006644010543823242}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:change_tag_def:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #146043, processing time: 0.061882972717285 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #146058 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #146058, processing time: 0.0070900917053223 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #146048 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:12-0!canonical!en","cache_time":"20230710213812","rev_id":12}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:12): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:12): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #146048, processing time: 0.044486045837402 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #146058 []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestRedirectTest): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\\Extension\\PageTriage\\Test\\MaintenancePopulateDraftQueueTestRedirectTest:templatelinks","lag":0,"age":0.0678558349609375,"walltime":0.021090030670166016}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestRedirectTest:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:210%3AMediaWiki\Extension\PageTriage\Test\MaintenancePopulateDraftQueueTestRedirectTest): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #146058, processing time: 0.13379406929016 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #146043 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #146043, processing time: 0.00022387504577637 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #146034 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #146034, processing time: 0.01665210723877 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #146113 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #146113, processing time: 0.0002439022064209 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #145994 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #145994, processing time: 0.02515697479248 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #146051 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestRedirectTest http://localhost:8080/w/index.php?title=Submissions:MediaWiki%5CExtension%5CPageTriage%5CTest%5CMaintenancePopulateDraftQueueTestRedirectTest&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #146051, processing time: 0.0031569004058838 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #146059 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #146059, processing time: 0.0069448947906494 []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[localisation] [debug] LocalisationCache using store LCStoreNull []
===
--
There were 2 failures:
1) MediaWiki\Extension\PageTriage\Test\ArticleMetadataTest::testGetMetadata
Failed asserting that an array has the key 'rev_count'.
/var/www/html/w/extensions/PageTriage/tests/phpunit/ArticleMetadataTest.php:123
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #130636 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #130636, processing time: 0.0038020610809326 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:5a8ec545aea21b125bb739a77470414e1d370131): miss, new value computed []
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[UserOptionsManager] [debug] Loading options from database {"user_id":38}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #129672 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #129672, processing time: 0.0041289329528809 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129672 []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:5a8ec545aea21b125bb739a77470414e1d370131): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:2-0!canonical!en","cache_time":"20230710213749","rev_id":2}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129672, processing time: 0.067896127700806 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #129728 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #129728, processing time: 0.10529613494873 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129701 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129701, processing time: 0.00014710426330566 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #129686 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #129686, processing time: 0.013357162475586 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129806 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129806, processing time: 0.00019001960754395 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #129818 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #129818, processing time: 0.0023999214172363 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129790 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129790, processing time: 0.089954137802124 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129679 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129679, processing time: 0.0061368942260742 []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A64): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:2): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:a5558d95b39d87548e65242b52b022814d04f1c0): miss, new value computed []
[UserOptionsManager] [debug] Loading options from database {"user_id":38}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #130483 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #130483, processing time: 0.0028350353240967 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #130483 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:a5558d95b39d87548e65242b52b022814d04f1c0): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:3-0!canonical!en","cache_time":"20230710213750","rev_id":3}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #130483, processing time: 0.043214082717896 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #129705 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #129705, processing time: 0.077430963516235 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129865 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129865, processing time: 0.00018000602722168 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #130477 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #130477, processing time: 0.013104915618896 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129185 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129185, processing time: 0.00031304359436035 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #129150 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #129150, processing time: 0.0028839111328125 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #130493 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #130493, processing time: 0.081712961196899 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #130484 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #130484, processing time: 0.0057179927825928 []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A65): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:3): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:8f172b720e4db64448af2656fef93b6513db2b4e): miss, new value computed []
[UserOptionsManager] [debug] Loading options from database {"user_id":38}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #129182 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #129182, processing time: 0.0036470890045166 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129182 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:8f172b720e4db64448af2656fef93b6513db2b4e): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:4-0!canonical!en","cache_time":"20230710213750","rev_id":4}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #129182, processing time: 0.049307823181152 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #128336 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #128336, processing time: 0.087985038757324 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129203 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129203, processing time: 0.0001530647277832 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #129118 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #129118, processing time: 0.01491904258728 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #137118 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #137118, processing time: 0.00028109550476074 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #137121 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #137121, processing time: 0.0040969848632812 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129187 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129187, processing time: 0.093944787979126 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129173 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129173, processing time: 0.0052480697631836 []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A66): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:4): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:2d18448516f0c356987bd134019989a36cb1c4c2): miss, new value computed []
[UserOptionsManager] [debug] Loading options from database {"user_id":38}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #128471 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #128471, processing time: 0.0034840106964111 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #128471 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:2d18448516f0c356987bd134019989a36cb1c4c2): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:5-0!canonical!en","cache_time":"20230710213751","rev_id":5}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #128471, processing time: 0.04345703125 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #137363 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #137363, processing time: 0.080361843109131 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #137130 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #137130, processing time: 0.00023889541625977 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #128617 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #128617, processing time: 0.015504837036133 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #128536 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #128536, processing time: 0.00018310546875 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #138044 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #138044, processing time: 0.0029008388519287 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #137138 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #137138, processing time: 0.085914134979248 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #137277 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #137277, processing time: 0.0058538913726807 []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A67): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:5): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:17a2eb68122398f531bfd5fdd9a0a80ccd030bbf): miss, new value computed []
[UserOptionsManager] [debug] Loading options from database {"user_id":38}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #128463 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #128463, processing time: 0.0036311149597168 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #128463 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:17a2eb68122398f531bfd5fdd9a0a80ccd030bbf): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:6-0!canonical!en","cache_time":"20230710213751","rev_id":6}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #128463, processing time: 0.042905807495117 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #129142 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #129142, processing time: 0.079127073287964 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129109 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #129109, processing time: 0.00014901161193848 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #137275 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #137275, processing time: 0.013307094573975 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #137180 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #137180, processing time: 0.00017881393432617 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #137438 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #137438, processing time: 0.003079891204834 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129047 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #129047, processing time: 0.090306997299194 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129108 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #129108, processing time: 0.0068149566650391 []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A68): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:6): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:4cd6ba997f559812bfc6d0992a3e6df3bda69541): miss, new value computed []
[UserOptionsManager] [debug] Loading options from database {"user_id":38}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #128419 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Title\Title::invalidateCache #128419, processing time: 0.0030970573425293 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #128419 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:118:4cd6ba997f559812bfc6d0992a3e6df3bda69541): miss, new value computed []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:7-0!canonical!en","cache_time":"20230710213752","rev_id":7}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #128419, processing time: 0.042815923690796 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #128399 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #128399, processing time: 0.081363916397095 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #128369 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #128369, processing time: 0.00018000602722168 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #128387 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #128387, processing time: 0.016155958175659 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129468 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #129468, processing time: 0.00027918815612793 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #128212 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #128212, processing time: 0.002748966217041 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #128394 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #128394, processing time: 0.083026170730591 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #128416 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #128416, processing time: 0.0051701068878174 []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[ParserCache] [debug] Parser cache options found {"name":"pcache"}
[ParserCache] [debug] ParserOutput cache found {"name":"pcache"}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A69): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:7): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A64): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:2:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:2): miss, new value computed []
[PageTriage] [debug] Article metadata not found in DB, will attempt to save to DB via the job queue. {"exception":{},"articles_without_metadata":"2","raw_query_string":""}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:2): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A65): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:3:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:3): miss, new value computed []
[PageTriage] [debug] Article metadata not found in DB, will attempt to save to DB via the job queue. {"exception":{},"articles_without_metadata":"3","raw_query_string":""}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:3): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A66): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:4:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:4): miss, new value computed []
[PageTriage] [debug] Article metadata not found in DB, will attempt to save to DB via the job queue. {"exception":{},"articles_without_metadata":"4","raw_query_string":""}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:4): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A67): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:5:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:5): miss, new value computed []
[PageTriage] [debug] Article metadata not found in DB, will attempt to save to DB via the job queue. {"exception":{},"articles_without_metadata":"5","raw_query_string":""}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:6:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:6:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A68): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:6:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:6:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:6): miss, new value computed []
[PageTriage] [debug] Article metadata not found in DB, will attempt to save to DB via the job queue. {"exception":{},"articles_without_metadata":"6","raw_query_string":""}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:6): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:7:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:7:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:SqlBlobStore-blob:my_wiki-unittest_:tt%3A69): miss, new value computed []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:7:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(global:revision-row-1.29:my_wiki-unittest_:7:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:7): miss, new value computed []
[PageTriage] [debug] Article metadata not found in DB, will attempt to save to DB via the job queue. {"exception":{},"articles_without_metadata":"7","raw_query_string":""}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-article-metadata:7): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
===
2) MediaWiki\Extension\PageTriage\Test\MaintenanceFixNominatedForDeletionTest::testSuccessfulFixNominatedForDeletion
Failed asserting that 1 is identical to 0.
/var/www/html/w/extensions/PageTriage/tests/phpunit/MaintenanceFixNominatedForDeletionTest.php:32
/var/www/html/w/tests/phpunit/includes/api/ApiTestCase.php:277
/var/www/html/w/tests/phpunit/MediaWikiIntegrationTestCase.php:518
=== Logs generated by test case
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"HashBagOStuff"}
[localisation] [debug] LocalisationCache using store LCStoreNull []
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #120431 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/User:UTSysop http://localhost:8080/w/index.php?title=User:UTSysop&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #120431, processing time: 0.0024120807647705 []
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"EmptyBagOStuff"}
[wfDebug] [debug] ParserFactory: using default preprocessor {"private":false}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ContentHandler] [info] Registered handler for wikitext: WikitextContentHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[ParserCache] [debug] Creating RevisionOutputCache instance for parsoid []
[ParserCache] [debug] Creating ParserCache instance for parsoid []
[MessageCache] [debug] MessageCache using store {class} {"class":"HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3ANominatedArticle): miss, new value computed []
[wfDebug] [debug] User::getBlockedStatus: checking blocked status for UTSysop {"private":false}
[UserOptionsManager] [debug] Loading options from database {"user_id":1}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:my_wiki-unittest_","lag":0,"age":0.03275322914123535,"walltime":0.005355119705200195}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:my_wiki-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:my_wiki-unittest_","lag":0,"age":0.04600214958190918,"walltime":0.004975795745849609}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:my_wiki-unittest_): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_RecentChange::notifyNew #120018 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_RecentChange::notifyNew #120018, processing time: 0.023668050765991 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started UserEditCountUpdate #143629 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended UserEditCountUpdate #143629, processing time: 0.0057840347290039 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #143631 []
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[ParserCache] [debug] Saved in parser cache {"name":"pcache","key":"my_wiki-unittest_:pcache:idhash:14-0!canonical!en","cache_time":"20230710213804","rev_id":14}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-content-model:14): miss, new value computed []
[objectcache] [debug] getWithSetCallback(my_wiki-unittest_:page-content-model:14): process cache hit []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page-restrictions:v1:14:14): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3ANominatedArticle): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #143631, processing time: 0.082942008972168 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started RefreshSecondaryDataUpdate #143629 []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:page:14:f101fef8cfe637832fae2eb051208a23f5bea4e5): miss, new value computed []
[wfDebug] [debug] BacklinkCache::queryLinks: got results from DB {"private":false}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3ANominatedArticle): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:numbacklinks:ns0%3ANominatedArticle:templatelinks): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:linktargetstore-id:0%3ANominatedArticle): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended RefreshSecondaryDataUpdate #143629, processing time: 0.16869497299194 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #120018 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #120018, processing time: 0.00028610229492188 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SearchUpdate #143663 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SearchUpdate #143663, processing time: 0.015557050704956 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_PurgeJobUtils::invalidatePages #143888 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_PurgeJobUtils::invalidatePages #143888, processing time: 0.0041749477386475 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #143899 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #143899, processing time: 0.00019407272338867 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started SiteStatsUpdate #143905 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended SiteStatsUpdate #143905, processing time: 0.025254964828491 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #119727 []
[GlobalTitleFail] [info] MessageCache::parse called with no title set. {"exception":{}}
[objectcache] [debug] fetchOrRegenerate(my_wiki-unittest_:pagetriage-valid-tags): miss, new value computed []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Extension\PageTriage\Hooks->onLinksUpdateComplete #119727, processing time: 0.10229182243347 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started CdnCacheUpdate #143639 []
[squid] [info] CdnCacheUpdate::purge: http://localhost:8080/wiki/NominatedArticle http://localhost:8080/w/index.php?title=NominatedArticle&action=history http://localhost:8080/wiki/Talk:NominatedArticle http://localhost:8080/w/index.php?title=Talk:NominatedArticle&action=history {"private":false}
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended CdnCacheUpdate #143639, processing time: 0.0032448768615723 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: started MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #143550 []
[DeferredUpdates] [debug] MediaWiki\Deferred\DeferredUpdatesManager::run: ended MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #143550, processing time: 0.0073390007019043 []
===
ERRORS!
Tests: 261, Assertions: 658, Errors: 8, Failures: 2, Skipped: 7.
You should really speed up these slow tests (>50ms)...
1. 9461ms to run MediaWiki\\Extension\\PageTriage\\Test\\ApiPageTriageListTest::testFilterType
2. 5739ms to run MediaWiki\\Extension\\PageTriage\\Test\\MaintenancePopulateDraftQueueTest::testPreExistingPagesWithCategoriesAreGivenCorrectTags
3. 4844ms to run MediaWiki\\Extension\\PageTriage\\Test\\ArticleMetadataTest::testGetMetadata
4. 4823ms to run MediaWiki\\Extension\\PageTriage\\Test\\ApiPageTriageListTest::testUndelete
5. 4674ms to run MediaWiki\\Extension\\PageTriage\\Test\\ArticleMetadataTest::testGetValidTags
6. 4420ms to run MediaWiki\\Extension\\PageTriage\\Test\\SpecialNewPagesFeedTest::testAddArticles
7. 3961ms to run MediaWiki\\Extension\\PageTriage\\Test\\ApiPageTriageListTest::testTalkpageFeedbackCount
8. 3568ms to run MediaWiki\\Extension\\PageTriage\\Test\\ArticleMetadataTest::testValidatePageIds
9. 3388ms to run MediaWiki\\Extension\\PageTriage\\Test\\ArticleMetadataTest::testValidCovers
10. 2734ms to run MediaWiki\\Extension\\PageTriage\\Test\\ApiPageTriageListTest::testFilterDateRange
...and there are 64 more above your threshold hidden from view