> phpunit 'extensions/Wikibase/repo/tests/phpunit/includes/ParserOutput/'
Using PHP 8.1.18
Running with MediaWiki settings because there might be integration tests
PHPUnit 9.6.19 by Sebastian Bergmann and contributors.

.................................SSSSSS........................  63 / 103 ( 61%)
....................EEEEE...............                        103 / 103 (100%)

Time: 00:07.236, Memory: 95.00 MB

There were 5 errors:

1) Wikibase\Repo\Tests\ParserOutput\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #0 (array())
Error: Undefined constant "Wikibase\Repo\Tests\ParserOutput\Garbage"

/var/www/html/w/extensions/Wikibase/repo/tests/phpunit/includes/ParserOutput/ReferencedEntitiesDataUpdaterTest.php:77
=== Logs generated by test case
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[CentralAuth] [debug] Loading state for global user {user} from DB {"user":"UTSysop"}
[CentralAuth] [debug] Loading attached wiki list for global user UTSysop from DB []
[CentralAuth] [debug] Loading groups for global user {user} {"user":"UTSysop"}
[objectcache] [debug] fetchOrRegenerate(global:centralauth-user:d480a9fdddfdc08a031132ca1cca6ace): miss, new value computed []
[CentralAuth] [debug] Loading CentralAuthUser for user {user} from cache object {"user":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":15075}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":15075,"walltime":0.002412080764770508}
[MessageCache] [debug] MessageCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[wfDebug] [debug] MediaWiki\Parser\ParserFactory: using default preprocessor {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":15804}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":15804,"walltime":0.002647876739501953}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:120:bdaf1eca33d4619e80e8ca689a1b74a4febbbb29): miss, new value computed []
[localisation] [debug] LocalisationCache::loadCoreData: got localisation for ban from source []
[ContentHandler] [info] Registered handler for wikibase-property: Wikibase\Repo\Content\PropertyHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[objectcache] [debug] MicroStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13305,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:wikidatawikidev-unittest_","lag":0,"age":0.8433539867401123,"walltime":0.0008530616760253906}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:wikidatawikidev-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_","lag":0,"age":0.8463039398193359,"walltime":0.0009450912475585938}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_): miss, new value computed []
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16750}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16750,"walltime":0.016299962997436523}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":10273}
[CentralAuth] [debug] Loading state for global user {user} from DB {"user":"UTSysop"}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":10273,"walltime":0.009902000427246094}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":16733}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":16733,"walltime":0.0022830963134765625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":16766}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":16766,"walltime":0.007753133773803711}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":16764}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"thisWikiIsTheRepo","logValue":"true"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"entitySources","logValue":"array (\n  'local' => \n  array (\n    'repoDatabase' => 'wikidatawikidev',\n    'entityNamespaces' => \n    array (\n      'item' => '122\/main',\n      'property' => '120\/main',\n      'lexeme' => '146\/main',\n    ),\n    'baseUri' => 'http:\/\/wikidatawikidev.mediawiki.mwdd.localhost:8080\/w\/index.php?title=Special:EntityData',\n    'rdfNodeNamespacePrefix' => 'wddev',\n    'rdfPredicateNamespacePrefix' => 'wddev',\n    'interwikiPrefix' => 'wikidatawikidev',\n  ),\n)"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"itemAndPropertySourceName","logValue":"'local'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGlobalID","logValue":"'wikidatawikidev'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGroup","logValue":"NULL"}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":16764,"walltime":0.03968000411987305}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":16625}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":16625,"walltime":0.0006380081176757812}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":10267}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":10267,"walltime":0.0032300949096679688}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":11111}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":11111,"walltime":0.002496004104614258}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":10259}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":10259,"walltime":0.006330013275146484}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":10702}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":10702,"walltime":0.028338909149169922}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":12645}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":12645,"walltime":0.002140045166015625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":12772}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":12772,"walltime":0.0019237995147705078}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId} {"updateId":10041}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId}, processing time: {walltime} {"updateId":10041,"walltime":0.0046539306640625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":10273}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item:P1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item_talk:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item_talk:P1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":10273,"walltime":0.0009980201721191406}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16767}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16767,"walltime":0.0009691715240478516}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:db5623b4d0989e14f815fb1d32b39b5644fa5aa9): miss, new value computed []
[ContentHandler] [info] Registered handler for wikibase-item: Wikibase\Repo\Content\ItemHandler []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13305,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":13137}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":13137,"walltime":0.012585163116455078}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13152}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13152,"walltime":0.003370046615600586}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":15293}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":15293,"walltime":0.002042055130004883}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":13199}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":13199,"walltime":0.007161140441894531}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13336}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13336,"walltime":0.03181791305541992}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":11842}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":11842,"walltime":0.0006661415100097656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":13151}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":13151,"walltime":0.0032739639282226562}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":12438}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":12438,"walltime":0.0033440589904785156}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":13147}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":13147,"walltime":0.004422187805175781}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13181}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13181,"walltime":0.0018908977508544922}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":13134}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":13134,"walltime":0.002048015594482422}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13152}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13152,"walltime":0.0008971691131591797}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":13190}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":13190,"walltime":0.0009961128234863281}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:cc08453d6d4977c2c21f0a2fcffe5162cdca0eb5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13305,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":14851}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":14851,"walltime":0.014677047729492188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13178}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13178,"walltime":0.0037767887115478516}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":13214}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":13214,"walltime":0.002034902572631836}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":13239}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":13239,"walltime":0.007583141326904297}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13146}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13146,"walltime":0.0329439640045166}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":12653}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":12653,"walltime":0.0007128715515136719}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":10051}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":10051,"walltime":0.0031080245971679688}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":13235}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":13235,"walltime":0.0027730464935302734}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":13243}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":13243,"walltime":0.004116058349609375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13310}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13310,"walltime":0.0018720626831054688}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":13233}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":13233,"walltime":0.00209808349609375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13178}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q20&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q20&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13178,"walltime":0.0009407997131347656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":12659}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":12659,"walltime":0.0009131431579589844}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:8a6e0915d612f5b7c1bf2842c64b496246834cde): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13305,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":15074}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":15074,"walltime":0.014372825622558594}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13509}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13509,"walltime":0.003289937973022461}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":13103}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":13103,"walltime":0.0019268989562988281}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":12754}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":12754,"walltime":0.008416175842285156}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13229}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13229,"walltime":0.030276060104370117}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":13170}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":13170,"walltime":0.0006740093231201172}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":8477}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":8477,"walltime":0.0030670166015625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":13437}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":13437,"walltime":0.002404928207397461}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":13471}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":13471,"walltime":0.0036199092864990234}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":12499}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":12499,"walltime":0.0016701221466064453}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":10954}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":10954,"walltime":0.0018529891967773438}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13509}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q21&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q21&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13509,"walltime":0.0007638931274414062}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":13257}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":13257,"walltime":0.0009818077087402344}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:64d30c2fe579f0e65901081bc490b1d5228c058a): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13305,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":14494}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":14494,"walltime":0.016324996948242188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13298}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13298,"walltime":0.0033750534057617188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":12077}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":12077,"walltime":0.0019021034240722656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":12073}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":12073,"walltime":0.006927967071533203}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13389}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13389,"walltime":0.03211402893066406}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":10336}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":10336,"walltime":0.0005910396575927734}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":12679}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":12679,"walltime":0.003103017807006836}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":13287}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":13287,"walltime":0.002721071243286133}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":11361}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":11361,"walltime":0.004055023193359375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13527}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13527,"walltime":0.0018298625946044922}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":13440}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":13440,"walltime":0.0019428730010986328}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13298}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q22&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q22&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13298,"walltime":0.0007660388946533203}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":13414}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":13414,"walltime":0.0008690357208251953}
===

2) Wikibase\Repo\Tests\ParserOutput\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #1 (array(Wikibase\DataModel\Entity\NumericPropertyId Object (...), Wikibase\DataModel\Entity\ItemId Object (...)))
Error: Undefined constant "Wikibase\Repo\Tests\ParserOutput\Garbage"

/var/www/html/w/extensions/Wikibase/repo/tests/phpunit/includes/ParserOutput/ReferencedEntitiesDataUpdaterTest.php:77
=== Logs generated by test case
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":16300}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":16300,"walltime":0.0026900768280029297}
[MessageCache] [debug] MessageCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[wfDebug] [debug] MediaWiki\Parser\ParserFactory: using default preprocessor {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":16651}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":16651,"walltime":0.003062009811401367}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:120:bdaf1eca33d4619e80e8ca689a1b74a4febbbb29): miss, new value computed []
[localisation] [debug] LocalisationCache::loadCoreData: got localisation for ban from source []
[ContentHandler] [info] Registered handler for wikibase-property: Wikibase\Repo\Content\PropertyHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[objectcache] [debug] MicroStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#16324,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:wikidatawikidev-unittest_","lag":0,"age":0.5912749767303467,"walltime":0.0009629726409912109}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:wikidatawikidev-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_","lag":0,"age":0.5943820476531982,"walltime":0.0009150505065917969}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_): miss, new value computed []
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":13668}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":13668,"walltime":0.018126964569091797}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":14170}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":14170,"walltime":0.006620168685913086}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":14104}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":14104,"walltime":0.0021610260009765625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":13811}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":13811,"walltime":0.007191181182861328}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":14139}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"thisWikiIsTheRepo","logValue":"true"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"entitySources","logValue":"array (\n  'local' => \n  array (\n    'repoDatabase' => 'wikidatawikidev',\n    'entityNamespaces' => \n    array (\n      'item' => '122\/main',\n      'property' => '120\/main',\n      'lexeme' => '146\/main',\n    ),\n    'baseUri' => 'http:\/\/wikidatawikidev.mediawiki.mwdd.localhost:8080\/w\/index.php?title=Special:EntityData',\n    'rdfNodeNamespacePrefix' => 'wddev',\n    'rdfPredicateNamespacePrefix' => 'wddev',\n    'interwikiPrefix' => 'wikidatawikidev',\n  ),\n)"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"itemAndPropertySourceName","logValue":"'local'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGlobalID","logValue":"'wikidatawikidev'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGroup","logValue":"NULL"}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":14139,"walltime":0.03969907760620117}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":13880}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":13880,"walltime":0.0006959438323974609}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":14190}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":14190,"walltime":0.003425121307373047}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":14102}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":14102,"walltime":0.0029349327087402344}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":13948}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":13948,"walltime":0.0041790008544921875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":14120}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":14120,"walltime":0.02861785888671875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":16844}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":16844,"walltime":0.00215911865234375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":14213}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":14213,"walltime":0.002070903778076172}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId} {"updateId":16894}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId}, processing time: {walltime} {"updateId":16894,"walltime":0.004700899124145508}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":14170}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item:P1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item_talk:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item_talk:P1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":14170,"walltime":0.00092315673828125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":13219}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":13219,"walltime":0.000926971435546875}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:db5623b4d0989e14f815fb1d32b39b5644fa5aa9): miss, new value computed []
[ContentHandler] [info] Registered handler for wikibase-item: Wikibase\Repo\Content\ItemHandler []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#16324,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16922}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16922,"walltime":0.012333869934082031}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":16941}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":16941,"walltime":0.0036318302154541016}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":16903}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":16903,"walltime":0.0020749568939208984}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":16940}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":16940,"walltime":0.0073699951171875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":16927}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":16927,"walltime":0.030006885528564453}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":16824}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":16824,"walltime":0.0006499290466308594}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":16911}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":16911,"walltime":0.0029630661010742188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":16936}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":16936,"walltime":0.0025060176849365234}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":16955}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":16955,"walltime":0.003583192825317383}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":16988}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":16988,"walltime":0.0016660690307617188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":16962}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":16962,"walltime":0.0017271041870117188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":16941}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":16941,"walltime":0.0007929801940917969}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16932}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16932,"walltime":0.000843048095703125}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:cc08453d6d4977c2c21f0a2fcffe5162cdca0eb5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#16324,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16918}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16918,"walltime":0.013367891311645508}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":16991}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":16991,"walltime":0.0038099288940429688}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":17009}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":17009,"walltime":0.002053976058959961}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":17024}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":17024,"walltime":0.006851911544799805}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":16919}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":16919,"walltime":0.031494855880737305}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":16971}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":16971,"walltime":0.0006101131439208984}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":16921}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":16921,"walltime":0.002749919891357422}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":17028}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":17028,"walltime":0.0026290416717529297}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17046}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17046,"walltime":0.003923177719116211}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":17079}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":17079,"walltime":0.0018229484558105469}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17053}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17053,"walltime":0.0019240379333496094}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":16991}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q20&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q20&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":16991,"walltime":0.000804901123046875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16923}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16923,"walltime":0.0008919239044189453}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:8a6e0915d612f5b7c1bf2842c64b496246834cde): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#16324,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16306}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16306,"walltime":0.014387130737304688}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":17099}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":17099,"walltime":0.0035331249237060547}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":17096}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":17096,"walltime":0.0021638870239257812}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":17112}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":17112,"walltime":0.006999969482421875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":17016}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":17016,"walltime":0.031057119369506836}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":17062}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":17062,"walltime":0.0006170272827148438}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":17120}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":17120,"walltime":0.002763032913208008}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":17125}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":17125,"walltime":0.0024290084838867188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17134}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17134,"walltime":0.0036940574645996094}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":17167}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":17167,"walltime":0.001728057861328125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17141}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17141,"walltime":0.0018868446350097656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":17099}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q21&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q21&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":17099,"walltime":0.0008199214935302734}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":17021}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":17021,"walltime":0.0009281635284423828}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:64d30c2fe579f0e65901081bc490b1d5228c058a): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#16324,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":13206}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":13206,"walltime":0.01585102081298828}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":17196}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":17196,"walltime":0.0033600330352783203}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":17184}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":17184,"walltime":0.00185394287109375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":17188}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":17188,"walltime":0.007950067520141602}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":17104}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":17104,"walltime":0.032727956771850586}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":17150}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":17150,"walltime":0.0006308555603027344}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":17198}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":17198,"walltime":0.002920866012573242}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":17199}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":17199,"walltime":0.0023980140686035156}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17209}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17209,"walltime":0.0033881664276123047}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":17242}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":17242,"walltime":0.0020182132720947266}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17216}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17216,"walltime":0.0020627975463867188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":17196}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q22&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q22&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":17196,"walltime":0.0008511543273925781}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":17109}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":17109,"walltime":0.0009229183197021484}
===

3) Wikibase\Repo\Tests\ParserOutput\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #2 (array(Wikibase\DataModel\Entity\ItemId Object (...)))
Error: Undefined constant "Wikibase\Repo\Tests\ParserOutput\Garbage"

/var/www/html/w/extensions/Wikibase/repo/tests/phpunit/includes/ParserOutput/ReferencedEntitiesDataUpdaterTest.php:77
=== Logs generated by test case
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":13636}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":13636,"walltime":0.0026099681854248047}
[MessageCache] [debug] MessageCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[wfDebug] [debug] MediaWiki\Parser\ParserFactory: using default preprocessor {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":13487}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":13487,"walltime":0.0026459693908691406}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:120:bdaf1eca33d4619e80e8ca689a1b74a4febbbb29): miss, new value computed []
[localisation] [debug] LocalisationCache::loadCoreData: got localisation for ban from source []
[ContentHandler] [info] Registered handler for wikibase-property: Wikibase\Repo\Content\PropertyHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[objectcache] [debug] MicroStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13760,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:wikidatawikidev-unittest_","lag":0,"age":0.2964310646057129,"walltime":0.0010020732879638672}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:wikidatawikidev-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_","lag":0,"age":0.2997140884399414,"walltime":0.0008609294891357422}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_): miss, new value computed []
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":17821}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":17821,"walltime":0.01647806167602539}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":17857}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":17857,"walltime":0.0063898563385009766}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":17804}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":17804,"walltime":0.0024819374084472656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":17837}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":17837,"walltime":0.007732868194580078}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":17835}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"thisWikiIsTheRepo","logValue":"true"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"entitySources","logValue":"array (\n  'local' => \n  array (\n    'repoDatabase' => 'wikidatawikidev',\n    'entityNamespaces' => \n    array (\n      'item' => '122\/main',\n      'property' => '120\/main',\n      'lexeme' => '146\/main',\n    ),\n    'baseUri' => 'http:\/\/wikidatawikidev.mediawiki.mwdd.localhost:8080\/w\/index.php?title=Special:EntityData',\n    'rdfNodeNamespacePrefix' => 'wddev',\n    'rdfPredicateNamespacePrefix' => 'wddev',\n    'interwikiPrefix' => 'wikidatawikidev',\n  ),\n)"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"itemAndPropertySourceName","logValue":"'local'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGlobalID","logValue":"'wikidatawikidev'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGroup","logValue":"NULL"}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":17835,"walltime":0.049796104431152344}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":17708}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":17708,"walltime":0.0006210803985595703}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":17855}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":17855,"walltime":0.0029211044311523438}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":17802}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":17802,"walltime":0.002527952194213867}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17903}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17903,"walltime":0.00403904914855957}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17900}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17900,"walltime":0.028402090072631836}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":9606}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":9606,"walltime":0.002521991729736328}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17933}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17933,"walltime":0.001965045928955078}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId} {"updateId":15887}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId}, processing time: {walltime} {"updateId":15887,"walltime":0.004188060760498047}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":17857}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item:P1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item_talk:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item_talk:P1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":17857,"walltime":0.0008940696716308594}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":17838}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":17838,"walltime":0.00090789794921875}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:db5623b4d0989e14f815fb1d32b39b5644fa5aa9): miss, new value computed []
[ContentHandler] [info] Registered handler for wikibase-item: Wikibase\Repo\Content\ItemHandler []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13760,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":15849}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":15849,"walltime":0.012078046798706055}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":16625}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":16625,"walltime":0.003545045852661133}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":15870}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":15870,"walltime":0.0019450187683105469}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":16758}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":16758,"walltime":0.007710933685302734}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":15476}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":15476,"walltime":0.0302431583404541}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":15970}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":15970,"walltime":0.0006570816040039062}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":15859}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":15859,"walltime":0.0028378963470458984}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":15113}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":15113,"walltime":0.0026810169219970703}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":13375}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":13375,"walltime":0.003662109375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":10541}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":10541,"walltime":0.0017621517181396484}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":11157}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":11157,"walltime":0.002128124237060547}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":16625}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":16625,"walltime":0.0009088516235351562}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16011}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16011,"walltime":0.0009148120880126953}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:cc08453d6d4977c2c21f0a2fcffe5162cdca0eb5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13760,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":15853}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":15853,"walltime":0.013900041580200195}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13495}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13495,"walltime":0.0036339759826660156}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":12658}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":12658,"walltime":0.0020949840545654297}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":12038}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":12038,"walltime":0.01577305793762207}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":15854}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":15854,"walltime":0.039093017578125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":13298}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":13298,"walltime":0.0008168220520019531}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":15848}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":15848,"walltime":0.0036029815673828125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":11103}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":11103,"walltime":0.0031490325927734375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":12752}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":12752,"walltime":0.004312038421630859}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":15218}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":15218,"walltime":0.002051115036010742}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":15800}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":15800,"walltime":0.0023229122161865234}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13495}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q20&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q20&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13495,"walltime":0.0010819435119628906}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":15844}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":15844,"walltime":0.0009870529174804688}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:8a6e0915d612f5b7c1bf2842c64b496246834cde): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13760,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":13666}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":13666,"walltime":0.018006086349487305}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":12461}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":12461,"walltime":0.004251956939697266}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":12699}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":12699,"walltime":0.0025157928466796875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":10618}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":10618,"walltime":0.007854938507080078}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13263}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13263,"walltime":0.033592939376831055}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":16603}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":16603,"walltime":0.0006289482116699219}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":10582}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":10582,"walltime":0.002788066864013672}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":10601}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":10601,"walltime":0.0030031204223632812}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":12391}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":12391,"walltime":0.003587961196899414}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":10616}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":10616,"walltime":0.0017309188842773438}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":12193}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":12193,"walltime":0.0019040107727050781}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":12461}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q21&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q21&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":12461,"walltime":0.0008020401000976562}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":12438}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":12438,"walltime":0.0009050369262695312}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:64d30c2fe579f0e65901081bc490b1d5228c058a): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13760,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16992}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16992,"walltime":0.016128063201904297}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":12920}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":12920,"walltime":0.0037300586700439453}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":12202}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":12202,"walltime":0.0019979476928710938}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":6804}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":6804,"walltime":0.006964921951293945}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":12908}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":12908,"walltime":0.03119206428527832}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":11641}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":11641,"walltime":0.0005910396575927734}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":12735}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":12735,"walltime":0.003036975860595703}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":11065}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":11065,"walltime":0.002767801284790039}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":11891}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":11891,"walltime":0.0045261383056640625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":11332}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":11332,"walltime":0.001984119415283203}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":12453}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":12453,"walltime":0.0019860267639160156}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":12920}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q22&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q22&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":12920,"walltime":0.0008161067962646484}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":12192}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":12192,"walltime":0.0008978843688964844}
===

4) Wikibase\Repo\Tests\ParserOutput\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #3 (array(Wikibase\DataModel\Entity\NumericPropertyId Object (...), Wikibase\DataModel\Entity\ItemId Object (...)))
Error: Undefined constant "Wikibase\Repo\Tests\ParserOutput\Garbage"

/var/www/html/w/extensions/Wikibase/repo/tests/phpunit/includes/ParserOutput/ReferencedEntitiesDataUpdaterTest.php:77
=== Logs generated by test case
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":17383}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":17383,"walltime":0.0023272037506103516}
[MessageCache] [debug] MessageCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[wfDebug] [debug] MediaWiki\Parser\ParserFactory: using default preprocessor {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":17135}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":17135,"walltime":0.002405881881713867}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:120:bdaf1eca33d4619e80e8ca689a1b74a4febbbb29): miss, new value computed []
[localisation] [debug] LocalisationCache::loadCoreData: got localisation for ban from source []
[ContentHandler] [info] Registered handler for wikibase-property: Wikibase\Repo\Content\PropertyHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[objectcache] [debug] MicroStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#17407,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:wikidatawikidev-unittest_","lag":0,"age":0.06279802322387695,"walltime":0.0009469985961914062}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:wikidatawikidev-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_","lag":0,"age":0.06582021713256836,"walltime":0.0008480548858642578}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_): miss, new value computed []
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":10887}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":10887,"walltime":0.016165971755981445}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":10312}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":10312,"walltime":0.0067901611328125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":13489}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":13489,"walltime":0.002043008804321289}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":13276}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":13276,"walltime":0.0076961517333984375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13251}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"thisWikiIsTheRepo","logValue":"true"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"entitySources","logValue":"array (\n  'local' => \n  array (\n    'repoDatabase' => 'wikidatawikidev',\n    'entityNamespaces' => \n    array (\n      'item' => '122\/main',\n      'property' => '120\/main',\n      'lexeme' => '146\/main',\n    ),\n    'baseUri' => 'http:\/\/wikidatawikidev.mediawiki.mwdd.localhost:8080\/w\/index.php?title=Special:EntityData',\n    'rdfNodeNamespacePrefix' => 'wddev',\n    'rdfPredicateNamespacePrefix' => 'wddev',\n    'interwikiPrefix' => 'wikidatawikidev',\n  ),\n)"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"itemAndPropertySourceName","logValue":"'local'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGlobalID","logValue":"'wikidatawikidev'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGroup","logValue":"NULL"}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13251,"walltime":0.04039597511291504}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":15833}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":15833,"walltime":0.0006248950958251953}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":13255}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":13255,"walltime":0.002972841262817383}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":14831}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":14831,"walltime":0.002412080764770508}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":16670}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":16670,"walltime":0.0035910606384277344}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":16557}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":16557,"walltime":0.02886509895324707}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13554}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13554,"walltime":0.0019981861114501953}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":13783}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":13783,"walltime":0.0018041133880615234}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId} {"updateId":16108}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId}, processing time: {walltime} {"updateId":16108,"walltime":0.004824161529541016}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":10312}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item:P1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item_talk:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item_talk:P1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":10312,"walltime":0.0009388923645019531}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":13282}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":13282,"walltime":0.0009260177612304688}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:db5623b4d0989e14f815fb1d32b39b5644fa5aa9): miss, new value computed []
[ContentHandler] [info] Registered handler for wikibase-item: Wikibase\Repo\Content\ItemHandler []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#17407,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":15974}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":15974,"walltime":0.011806964874267578}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13292}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13292,"walltime":0.0033588409423828125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":16120}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":16120,"walltime":0.0019071102142333984}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":15199}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":15199,"walltime":0.006811857223510742}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":15892}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":15892,"walltime":0.030740976333618164}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":16184}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":16184,"walltime":0.00061798095703125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":16121}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":16121,"walltime":0.0029540061950683594}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":13238}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":13238,"walltime":0.0027379989624023438}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":16674}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":16674,"walltime":0.003551006317138672}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":16284}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":16284,"walltime":0.0017540454864501953}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":16699}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":16699,"walltime":0.0018281936645507812}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13292}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13292,"walltime":0.0008161067962646484}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16141}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16141,"walltime":0.0008652210235595703}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:cc08453d6d4977c2c21f0a2fcffe5162cdca0eb5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#17407,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16106}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16106,"walltime":0.013110160827636719}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":16272}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":16272,"walltime":0.003237009048461914}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":13782}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":13782,"walltime":0.0019447803497314453}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":16700}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":16700,"walltime":0.007425785064697266}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":16105}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":16105,"walltime":0.02960205078125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":16720}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":16720,"walltime":0.0006580352783203125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":15538}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":15538,"walltime":0.002847909927368164}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":16690}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":16690,"walltime":0.0023651123046875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":16717}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":16717,"walltime":0.003351926803588867}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13210}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13210,"walltime":0.0017740726470947266}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":13498}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":13498,"walltime":0.0020210742950439453}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":16272}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q20&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q20&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":16272,"walltime":0.0008471012115478516}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":15975}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":15975,"walltime":0.0008680820465087891}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:8a6e0915d612f5b7c1bf2842c64b496246834cde): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#17407,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":17389}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":17389,"walltime":0.015398025512695312}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":12426}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":12426,"walltime":0.003525972366333008}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":13812}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":13812,"walltime":0.0019409656524658203}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":16302}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":16302,"walltime":0.006910085678100586}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13191}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13191,"walltime":0.030786991119384766}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":13867}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":13867,"walltime":0.0006139278411865234}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":13672}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":13672,"walltime":0.003306150436401367}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":11102}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":11102,"walltime":0.0028510093688964844}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":13228}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":13228,"walltime":0.0036950111389160156}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13842}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13842,"walltime":0.001622915267944336}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":13964}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":13964,"walltime":0.0018041133880615234}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":12426}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q21&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q21&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":12426,"walltime":0.0007588863372802734}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16685}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16685,"walltime":0.0008471012115478516}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:64d30c2fe579f0e65901081bc490b1d5228c058a): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#17407,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":13283}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":13283,"walltime":0.015902996063232422}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13913}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13913,"walltime":0.0037529468536376953}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":12694}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":12694,"walltime":0.0020189285278320312}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":13109}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":13109,"walltime":0.007611989974975586}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":13900}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":13900,"walltime":0.030657052993774414}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":13923}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":13923,"walltime":0.0006129741668701172}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":13915}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":13915,"walltime":0.002933979034423828}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":10899}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":10899,"walltime":0.0025360584259033203}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":12853}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":12853,"walltime":0.0035469532012939453}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13958}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13958,"walltime":0.0016949176788330078}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":11161}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":11161,"walltime":0.0018410682678222656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13913}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q22&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q22&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13913,"walltime":0.0008091926574707031}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":10329}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":10329,"walltime":0.0009210109710693359}
===

5) Wikibase\Repo\Tests\ParserOutput\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #4 (array(Wikibase\DataModel\Entity\NumericPropertyId Object (...), Wikibase\DataModel\Entity\ItemId Object (...), Wikibase\DataModel\Entity\ItemId Object (...), Wikibase\DataModel\Entity\ItemId Object (...)))
Error: Undefined constant "Wikibase\Repo\Tests\ParserOutput\Garbage"

/var/www/html/w/extensions/Wikibase/repo/tests/phpunit/includes/ParserOutput/ReferencedEntitiesDataUpdaterTest.php:77
=== Logs generated by test case
[localisation] [debug] LocalisationCache using store LCStoreNull []
[objectcache] [debug] MainWANObjectCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":10121}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":10121,"walltime":0.002432107925415039}
[MessageCache] [debug] MessageCache using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[wfDebug] [debug] MediaWiki\Parser\ParserFactory: using default preprocessor {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId} {"updateId":12406}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\User\UserGroupManager->addUserToGroup #{updateId}, processing time: {walltime} {"updateId":12406,"walltime":0.0022230148315429688}
[localisation] [debug] LocalisationCache::isExpired(en): cache missing, need to make one []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:120:bdaf1eca33d4619e80e8ca689a1b74a4febbbb29): miss, new value computed []
[localisation] [debug] LocalisationCache::loadCoreData: got localisation for ban from source []
[ContentHandler] [info] Registered handler for wikibase-property: Wikibase\Repo\Content\PropertyHandler []
[objectcache] [debug] MainObjectStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[ParserCache] [debug] Creating ParserCache instance for pcache []
[objectcache] [debug] MicroStash using store {class} {"class":"Wikimedia\\ObjectCache\\HashBagOStuff"}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13167,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:content_models:wikidatawikidev-unittest_","lag":0,"age":0.7627570629119873,"walltime":0.0008609294891357422}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:content_models:wikidatawikidev-unittest_): miss, new value computed []
[objectcache] [warning] Rejected set() for {cachekey} due to pending writes. {"cachekey":"global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_","lag":0,"age":0.7659890651702881,"walltime":0.0008800029754638672}
[objectcache] [debug] fetchOrRegenerate(global:NameTableSqlStore:slot_roles:wikidatawikidev-unittest_): miss, new value computed []
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16981}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16981,"walltime":0.015865087509155273}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":17134}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":17134,"walltime":0.006876945495605469}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":17050}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":17050,"walltime":0.002349853515625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":17003}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":17003,"walltime":0.008605003356933594}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":17022}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"thisWikiIsTheRepo","logValue":"true"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"entitySources","logValue":"array (\n  'local' => \n  array (\n    'repoDatabase' => 'wikidatawikidev',\n    'entityNamespaces' => \n    array (\n      'item' => '122\/main',\n      'property' => '120\/main',\n      'lexeme' => '146\/main',\n    ),\n    'baseUri' => 'http:\/\/wikidatawikidev.mediawiki.mwdd.localhost:8080\/w\/index.php?title=Special:EntityData',\n    'rdfNodeNamespacePrefix' => 'wddev',\n    'rdfPredicateNamespacePrefix' => 'wddev',\n    'interwikiPrefix' => 'wikidatawikidev',\n  ),\n)"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"itemAndPropertySourceName","logValue":"'local'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGlobalID","logValue":"'wikidatawikidev'"}
[Wikibase] [debug] {method}: setting {settingName} was given as a closure, resolve it to {logValue} {"method":"Wikibase\\Lib\\SettingsArray::getSetting","settingName":"siteGroup","logValue":"NULL"}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:120%3AP1): miss, new value computed []
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[Wikibase] [debug] {method}: updating cache after updating property {id} {"method":"Wikibase\\Lib\\Store\\CacheAwarePropertyInfoStore::setPropertyInfo","id":"P1"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":17022,"walltime":0.04536700248718262}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":16965}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":16965,"walltime":0.0006861686706542969}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":17113}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":17113,"walltime":0.003493070602416992}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":16993}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":16993,"walltime":0.0031270980834960938}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17147}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17147,"walltime":0.004320859909057617}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17036}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17036,"walltime":0.030159950256347656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":18178}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":18178,"walltime":0.0024797916412353516}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17187}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17187,"walltime":0.0022230148315429688}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId} {"updateId":18228}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Extension\Notifications\Mapper\NotificationMapper::insert #{updateId}, processing time: {walltime} {"updateId":18228,"walltime":0.004873037338256836}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":17134}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item:P1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Item_talk:P1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Item_talk:P1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":17134,"walltime":0.0010571479797363281}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16971}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16971,"walltime":0.0010440349578857422}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:db5623b4d0989e14f815fb1d32b39b5644fa5aa9): miss, new value computed []
[ContentHandler] [info] Registered handler for wikibase-item: Wikibase\Repo\Content\ItemHandler []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13167,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":18256}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":18256,"walltime":0.012151002883911133}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":18275}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":18275,"walltime":0.0033860206604003906}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":18237}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":18237,"walltime":0.0018839836120605469}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":18274}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":18274,"walltime":0.017821073532104492}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":18261}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ1): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":18261,"walltime":0.030989885330200195}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":18158}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":18158,"walltime":0.0006198883056640625}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":18245}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":18245,"walltime":0.0027391910552978516}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":18270}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":18270,"walltime":0.002393960952758789}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":18290}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":18290,"walltime":0.0036001205444335938}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":10038}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":10038,"walltime":0.0018949508666992188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17374}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17374,"walltime":0.0018799304962158203}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":18275}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q1&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q1 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q1&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":18275,"walltime":0.0008249282836914062}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":18266}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":18266,"walltime":0.000888824462890625}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:cc08453d6d4977c2c21f0a2fcffe5162cdca0eb5): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13167,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":18252}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":18252,"walltime":0.013233184814453125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":13099}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":13099,"walltime":0.0033240318298339844}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":15752}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":15752,"walltime":0.001934051513671875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":17424}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":17424,"walltime":0.007182121276855469}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":18253}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ20): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":18253,"walltime":0.030436038970947266}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":17602}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":17602,"walltime":0.0007159709930419922}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":18255}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":18255,"walltime":0.0030820369720458984}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":13997}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":13997,"walltime":0.002758026123046875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":16515}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":16515,"walltime":0.003740072250366211}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":13841}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":13841,"walltime":0.0018410682678222656}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":16614}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":16614,"walltime":0.0021209716796875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":13099}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q20&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q20 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q20&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":13099,"walltime":0.0007860660552978516}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":18257}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":18257,"walltime":0.0010190010070800781}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:8a6e0915d612f5b7c1bf2842c64b496246834cde): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13167,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16728}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16728,"walltime":0.0141448974609375}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":16161}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":16161,"walltime":0.003556966781616211}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":16158}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":16158,"walltime":0.0019490718841552734}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":14219}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":14219,"walltime":0.006843090057373047}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":16580}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ21): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":16580,"walltime":0.03109002113342285}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":15471}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":15471,"walltime":0.0005700588226318359}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":16157}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":16157,"walltime":0.0026710033416748047}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":16207}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":16207,"walltime":0.0028100013732910156}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":15754}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":15754,"walltime":0.0036079883575439453}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":12999}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":12999,"walltime":0.0017271041870117188}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17580}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17580,"walltime":0.0018019676208496094}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":16161}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q21&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q21 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q21&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":16161,"walltime":0.0007560253143310547}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":16583}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":16583,"walltime":0.0009679794311523438}
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:page:122:64d30c2fe579f0e65901081bc490b1d5228c058a): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[BlockManager] [debug] Block cache miss with key BlockCacheKey{request=none,user=#13167,primary} []
[UserOptionsManager] [debug] Loading options from database {"user_id":1,"user_name":"UTSysop"}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId} {"updateId":16312}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_RecentChange::notifyNew #{updateId}, processing time: {walltime} {"updateId":16312,"walltime":0.015434980392456055}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId} {"updateId":15096}
[CheckUser] [error] Unable to find central ID for local user {username} when recording action in cuci_user table. {"username":"UTSysop","exception":{}}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\CheckUser\Services\CheckUserInsert->recordActionInCentralTablesOnDeferredUpdate #{updateId}, processing time: {walltime} {"updateId":15096,"walltime":0.0037641525268554688}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\UserEditCountUpdate #{updateId} {"updateId":15764}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\UserEditCountUpdate #{updateId}, processing time: {walltime} {"updateId":15764,"walltime":0.002007007598876953}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId} {"updateId":15770}
[SaveParse] [debug] MediaWiki\Revision\RenderedRevision::pruneRevisionSensitiveOutput: no prepared revision output []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AtomicSectionUpdate_MediaWiki\Storage\PageUpdater::getAtomicSectionUpdate #{updateId}, processing time: {walltime} {"updateId":15770,"walltime":0.0069599151611328125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId} {"updateId":16454}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[objectcache] [debug] fetchOrRegenerate(wikidatawikidev-unittest_:linktargetstore-id:122%3AQ22): miss, new value computed []
[Wikibase] [debug] {method}: links did not change, returning. {"method":"Wikibase\\Lib\\Store\\Sql\\SiteLinkTable::saveLinksOfItem"}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\RefreshSecondaryDataUpdate #{updateId}, processing time: {walltime} {"updateId":16454,"walltime":0.03027510643005371}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId} {"updateId":15756}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\DerivedPageDataUpdater->doUpdates #{updateId}, processing time: {walltime} {"updateId":15756,"walltime":0.0006310939788818359}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SearchUpdate #{updateId} {"updateId":15781}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SearchUpdate #{updateId}, processing time: {walltime} {"updateId":15781,"walltime":0.002733945846557617}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId} {"updateId":15079}
[BacklinkCache] [debug] MediaWiki\Cache\BacklinkCache::queryLinks: got results from DB []
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_WikiPage::onArticleCreate #{updateId}, processing time: {walltime} {"updateId":15079,"walltime":0.00257110595703125}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId} {"updateId":17934}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Extension\Notifications\Hooks->onPageSaveComplete #{updateId}, processing time: {walltime} {"updateId":17934,"walltime":0.003826141357421875}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId} {"updateId":15796}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\AutoCommitUpdate_MediaWiki\Deferred\LinksUpdate\LinksUpdate::doUpdate #{updateId}, processing time: {walltime} {"updateId":15796,"walltime":0.0018601417541503906}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\SiteStatsUpdate #{updateId} {"updateId":17361}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\SiteStatsUpdate #{updateId}, processing time: {walltime} {"updateId":17361,"walltime":0.0020570755004882812}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\CdnCacheUpdate #{updateId} {"updateId":15096}
[squid] [info] MediaWiki\Deferred\CdnCacheUpdate::purge: http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property:Q22&action=history http://wikidatawikidev.mediawiki.mwdd.localhost:80/wiki/Property_talk:Q22 http://wikidatawikidev.mediawiki.mwdd.localhost:80/index.php?title=Property_talk:Q22&action=history {"private":false}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\CdnCacheUpdate #{updateId}, processing time: {walltime} {"updateId":15096,"walltime":0.0008180141448974609}
[DeferredUpdates] [debug] DeferredUpdates::run: started MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId} {"updateId":14224}
[DeferredUpdates] [debug] DeferredUpdates::run: ended MediaWiki\Deferred\MWCallableUpdate_MediaWiki\Storage\PageUpdater->saveRevision #{updateId}, processing time: {walltime} {"updateId":14224,"walltime":0.0009198188781738281}
===

ERRORS!
Tests: 103, Assertions: 190, Errors: 5, Skipped: 6.


You should really speed up these slow tests (>100ms)...
 1. 792ms to run Wikibase\\Repo\\Tests\\ParserOutput\\FullEntityParserOutputGeneratorIntegrationTest::testGetParserOutputIncludesLabelsOfRedirectEntityUsedAsStatementValue
 2. 754ms to run Wikibase\\Repo\\Tests\\ParserOutput\\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #2
 3. 753ms to run Wikibase\\Repo\\Tests\\ParserOutput\\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #0
 4. 732ms to run Wikibase\\Repo\\Tests\\ParserOutput\\ReferencedEntitiesDataUpdaterTest::testValidCovers
 5. 728ms to run Wikibase\\Repo\\Tests\\ParserOutput\\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #4
 6. 721ms to run Wikibase\\Repo\\Tests\\ParserOutput\\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #1
 7. 705ms to run Wikibase\\Repo\\Tests\\ParserOutput\\FullEntityParserOutputGeneratorIntegrationTest::testParserOutputContainsLinksForItemsUsedAsQuantity
 8. 700ms to run Wikibase\\Repo\\Tests\\ParserOutput\\ReferencedEntitiesDataUpdaterTest::testUpdateParserOutput with data set #3
 9. 226ms to run Wikibase\\Repo\\Tests\\ParserOutput\\EntityParserOutputGeneratorFactoryTest::testGetEntityParserOutputGenerator
Script phpunit handling the phpunit event returned with error code 2
Script @phpunit was called via phpunit:entrypoint