Page MenuHomePhabricator

SlowTimer for two PHPunit tests, possibly from Wikibase
Open, Needs TriagePublic

Description

Looking at https://integration.wikimedia.org/ci/job/quibble-vendor-mysql-hhvm-docker/26780/console, there are two tests emitting a SlowTimer warning:

18:29:27 ..............................SlowTimer [1356ms] at runtime/ext_mysql: slow query: INSERT /* ManualLogEntry::insert nobody@3d9c0bdc... */  INTO `unittest_logging` (log_type,log_action,log_timestamp,log_namespace,log_title,log_page,log_params,log_comment_id,log_user,log_user_text) VALUES ('create','create','20181203172926','146','L1','12','a:1:{s:17:\"associated_rev_id\";i:23;}','10','2','TestUser e52411.062')
18:29:35 ...............................  366 / 4007 (  9%)
18:30:47 ........SlowTimer [1149ms] at runtime/ext_mysql: slow query: INSERT /* ManualLogEntry::insert nobody@3d9c0bdc... */  INTO `unittest_logging` (log_type,log_action,log_timestamp,log_namespace,log_title,log_page,log_params,log_comment_id,log_user,log_user_text) VALUES ('create','create','20181203173046','146','L3','3','a:1:{s:17:\"associated_rev_id\";i:3;}','4','0','127.0.0.1')
18:30:52 ...................SSS...............................  671 / 4007 ( 16%)

The tests are successful anyway, and overall the job succeeds, but this shouldn't happen. I think these are coming from Wikibase because log_title takes the values of "L1" and "L3", which I could only find in Wikibase tests.

Event Timeline

Daimona created this task.Dec 3 2018, 5:40 PM
Restricted Application added a subscriber: Aklapper. · View Herald TranscriptDec 3 2018, 5:40 PM
hashar added a subscriber: hashar.

I do not know whether it still occurs, I haven't checked. Maybe the SQL database is too slow :(