https://bugzilla.wikimedia.org/show_bug.cgi?id=68620
Bug ID: 68620
Summary: slow query: INSERT /* JobQueueDB::doBatchPush
127.0.0.1 */ INTO `unittest_job` etc.
Product: MediaWiki
Version: unspecified
Hardware: All
OS: All
Status: NEW
Severity: normal
Priority: Unprioritized
Component: General/Unknown
Assignee: [email protected]
Reporter: [email protected]
Web browser: ---
Mobile Platform: ---
Ubuntu 14.04, HipHop VM 3.3.0-dev, labs-vagrant with simple_performant role
enabled. this is a bit ugly:
vagrant@nemobis:/srv/vagrant/mediawiki/tests/phpunit$ php phpunit.php
PHPUnit 4.1.4 by Sebastian Bergmann.
Configuration read from /srv/vagrant/mediawiki/tests/phpunit/suite.xml
[...]
..........................SlowTimer [1329ms] at runtime/ext_mysql: slow query:
INSERT /* JobQueueDB::doBatchPush 127.0.0.1 */ INTO `unittest_job`
(job_cmd,job_namespace,job_title,job_params,job_id,job_timestamp,job_sha1,job_random)
VALUES
('null','0','Main_Page','a:6:{s:5:\"lives\";i:0;s:6:\"usleep\";i:0;s:16:\"removeDuplicates\";i:0;s:1:\"i\";i:0;s:16:\"rootJobSignature\";s:40:\"486b449fb5b520e6228c37ee539588f8b7174664\";s:16:\"rootJobTimestamp\";s:14:\"20140726153847\";}',NULL,'20140726153847','lfcfwgp44xsmdatbc75gzx5yl8hqy16','2073081733')
................................... 3294 / 8426 ( 39%)
[...]
.......................................SlowTimer [1104ms] at runtime/ext_mysql:
slow query: INSERT /* NewParserTest::addDBData 127.0.0.1 */ INTO
`unittest_site_stats` (ss_row_id,ss_images,ss_good_articles) VALUES
('1','2','1')
................SlowTimer [1237ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'Main_Page'
LIMIT 1
SlowTimer [1767ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Foo'
LIMIT 1
...... 4514 / 8426 ( 53%)
........................................SlowTimer [1130ms] at
runtime/ext_mysql: slow query: DELETE /* MediaWikiTestCase::resetDB 127.0.0.1
*/ FROM `unittest_site_stats`
SlowTimer [1409ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'UTPage'
LIMIT 1
SlowTimer [1094ms] at runtime/ext_mysql: slow query: INSERT /*
NewParserTest::addDBData 127.0.0.1 */ INTO `unittest_site_stats`
(ss_row_id,ss_images,ss_good_articles) VALUES ('1','2','1')
SlowTimer [1515ms] at runtime/ext_mysql: slow query: SELECT /*
DatabaseBase::selectField 127.0.0.1 */ 1 FROM `unittest_image` WHERE
img_name = 'Foobar.jpg' LIMIT 1
SlowTimer [1304ms] at runtime/ext_mysql: slow query: SELECT /*
DatabaseBase::selectField 127.0.0.1 */ 1 FROM `unittest_image` WHERE
img_name = 'Thumb.png' LIMIT 1
SlowTimer [1106ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'Main_Page'
LIMIT 1
.SlowTimer [1182ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'UTPage'
LIMIT 1
SlowTimer [1549ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Foo'
LIMIT 1
SlowTimer [1465ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Pipe'
LIMIT 1
SlowTimer [1527ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '8' AND page_title =
'Bad_image_list' LIMIT 1
SlowTimer [1579ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title =
'Inner_list' LIMIT 1
.SlowTimer [1002ms] at runtime/ext_mysql: slow query: DELETE /*
MediaWikiTestCase::resetDB 127.0.0.1 */ FROM `unittest_site_stats`
SlowTimer [1263ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'UTPage'
LIMIT 1
SlowTimer [1205ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'Main_Page'
LIMIT 1
SlowTimer [5983ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Foo'
LIMIT 1
SlowTimer [1680ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Pipe'
LIMIT 1
SlowTimer [1858ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title =
'Inner_list' LIMIT 1
SlowTimer [1111ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title =
'Tbl-start' LIMIT 1
................... 4575 / 8426 ( 54%)
.........SlowTimer [3465ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'Main_Page'
LIMIT 1
SlowTimer [1969ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Foo'
LIMIT 1
SlowTimer [1455ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Blank'
LIMIT 1
SlowTimer [1271ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '10' AND page_title = 'Pipe'
LIMIT 1
SlowTimer [3423ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '8' AND page_title =
'Bad_image_list' LIMIT 1
.................................................... 4636 / 8426 ( 55%)
............................................................. 4697 / 8426 (
55%)
......SlowTimer [1019ms] at runtime/ext_mysql: slow query: DELETE /*
MediaWikiTestCase::resetDB 127.0.0.1 */ FROM `unittest_site_stats`
........................................SlowTimer [1041ms] at
runtime/ext_mysql: slow query: DELETE /* MediaWikiTestCase::resetDB 127.0.0.1
*/ FROM `unittest_site_stats`
SlowTimer [2148ms] at runtime/ext_mysql: slow query: SELECT /* User::idForName
127.0.0.1 */ user_id FROM `unittest_user` WHERE user_name = 'UTSysop'
LIMIT 1
SlowTimer [1235ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title = 'UTPage'
LIMIT 1
............... 4758 / 8426 ( 56%)
.......................................................SlowTimer [1748ms] at
runtime/ext_mysql: slow query: SELECT /* WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '100' AND page_title =
'AlphaTest' LIMIT 1
SlowTimer [6289ms] at runtime/ext_mysql: slow query: SELECT /*
WikiPage::pageData 127.0.0.1 */
page_id,page_namespace,page_title,page_restrictions,page_counter,page_is_redirect,page_is_new,page_random,page_touched,page_links_updated,page_latest,page_len,page_content_model
FROM `unittest_page` WHERE page_namespace = '0' AND page_title =
'7%_Solution' LIMIT 1
.SlowTimer [4067ms] at runtime/ext_mysql: slow query: DELETE /*
MediaWikiTestCase::resetDB 127.0.0.1 */ FROM `unittest_site_stats`
..... 4819 / 8426 ( 57%)
............................................................. 4880 / 8426 (
57%)
.........................SlowTimer [1457ms] at runtime/ext_mysql: slow query:
SELECT /* MessageCache::loadFromDB(en)-big 127.0.0.1 */ page_title FROM
`unittest_page` WHERE page_is_redirect = '0' AND page_namespace = '8' AND
(page_title NOT LIKE '%/%' ) AND (page_len > 10000)
.................................... 4941 / 8426 ( 58%)
............................................................. 5002 / 8426 (
59%)
....................SlowTimer [1847ms] at runtime/ext_mysql: slow query: DELETE
/* MediaWikiTestCase::resetDB 127.0.0.1 */ FROM `unittest_site_stats`
SlowTimer [4315ms] at runtime/ext_mysql: slow query: SELECT /* User::idForName
127.0.0.1 */ user_id FROM `unittest_user` WHERE user_name = 'UTSysop'
LIMIT 1
......................................... 5063 / 8426 ( 60%)
[...]
--
You are receiving this mail because:
You are the assignee for the bug.
You are on the CC list for the bug.
_______________________________________________
Wikibugs-l mailing list
[email protected]
https://lists.wikimedia.org/mailman/listinfo/wikibugs-l
