Console Output

15:27:12 Started by user anonymous
15:27:12 Building remotely on integration-slave-docker-1003 (DebianJessieDocker m4executor) in workspace /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker
15:27:12 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins7609854148937156044.sh
15:27:12 + mkdir -m 2777 -p cache
15:27:12 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins6889049222834246853.sh
15:27:12 setup-docker-quibble-initShow Details
+ exec docker run --rm --env-file /dev/fd/63 --volume /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/cache:/cache docker-registry.wikimedia.org/releng/castor:0.1.3 load
15:27:12 ++ /usr/bin/env
15:27:12 ++ egrep -v '^(HOME|SHELL|PATH|LOGNAME|MAIL|HHVM_REPO_CENTRAL_PATH)='
15:27:12 Defined: CASTOR_NAMESPACE="castor-mw-ext-and-skins/REL1_27/quibble-composer-mysql-php70-docker"
15:27:12 Syncing...
15:27:12 rsync: change_dir "/castor-mw-ext-and-skins/REL1_27/quibble-composer-mysql-php70-docker" (in caches) failed: No such file or directory (2)
15:27:13 rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1668) [Receiver=3.1.2]
15:27:13 rsync: read error: Connection reset by peer (104)
15:27:13 
15:27:13 Done
15:27:13 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins4530842596544764714.sh
15:27:13 + set -eux
15:27:13 + mkdir -m 2777 -p log
15:27:13 + docker run --rm --user=nobody -v /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker:/workspace --entrypoint=/usr/bin/find docker-registry.wikimedia.org/wikimedia-stretch:latest /workspace/log -mindepth 1 -delete
15:27:14 [quibble-composer-mysql-php70-docker] $ /bin/bash -eu /tmp/jenkins5096818351310960895.sh
15:27:14 ++ pwd
15:27:14 ++ /usr/bin/env
15:27:14 ++ egrep -v '^(HOME|SHELL|PATH|LOGNAME|MAIL|HHVM_REPO_CENTRAL_PATH)='
15:27:14 ++ pwd
15:27:14 + exec docker run --volume /srv/git:/srv/git:ro --rm --env-file /dev/fd/63 --volume /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/log:/log --volume /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/cache:/cache docker-registry.wikimedia.org/releng/quibble-stretch:0.0.18-2 --packages-source composer --db mysql
15:27:14 DEBUG:quibble.cmd:Running stages: phpunit, npm-test, composer-test, qunit, selenium
15:27:14 DEBUG:quibble.cmd:ZUUL_PROJECT=mediawiki/extensions/BlueSpiceSubPageTree
15:27:14 INFO:quibble.cmd:Projects: mediawiki/core, mediawiki/skins/Vector, mediawiki/extensions/BlueSpiceSubPageTree, mediawiki/extensions/BlueSpiceFoundation
15:27:14 INFO:zuul.CloneMapper:Workspace path set to: /workspace/src
15:27:14 INFO:zuul.CloneMapper:Mapping projects to workspace...
15:27:14 INFO:zuul.CloneMapper:  mediawiki/core -> /workspace/src
15:27:14 INFO:zuul.CloneMapper:  mediawiki/skins/Vector -> /workspace/src/skins/Vector
15:27:14 INFO:zuul.CloneMapper:  mediawiki/extensions/BlueSpiceSubPageTree -> /workspace/src/extensions/BlueSpiceSubPageTree
15:27:14 INFO:zuul.CloneMapper:  mediawiki/extensions/BlueSpiceFoundation -> /workspace/src/extensions/BlueSpiceFoundation
15:27:14 DEBUG:zuul.CloneMapper:Checking overlap in destination directories...
15:27:14 INFO:zuul.CloneMapper:Expansion completed.
15:27:14 INFO:zuul.Cloner:Preparing 4 repositories
15:27:14 INFO:zuul.Cloner:Creating repo mediawiki/core from cache /srv/git/mediawiki/core.git
15:27:18 INFO:zuul.Cloner:Updating origin remote in repo mediawiki/core to https://gerrit.wikimedia.org/r/p/mediawiki/core
15:27:19 DEBUG:zuul.Repo:Pruning stale refs: [<git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.26">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.27">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.28">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.29">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.30">]
15:27:19 DEBUG:zuul.Repo:Resetting repository /workspace/src
15:27:19 DEBUG:zuul.Repo:Updating repository /workspace/src
15:27:31 INFO:zuul.Cloner:upstream repo has branch REL1_27
15:27:32 DEBUG:zuul.Cloner:Fetched ref REL1_27 from mediawiki/core
15:27:32 DEBUG:zuul.Repo:Checking out 08f9d35fad9558cc82f7b3cc73c695feff756a02
15:27:34 INFO:zuul.Cloner:Prepared mediawiki/core repo with commit 08f9d35fad9558cc82f7b3cc73c695feff756a02
15:27:34 INFO:zuul.Cloner:Creating repo mediawiki/skins/Vector from upstream https://gerrit.wikimedia.org/r/p/mediawiki/skins/Vector
15:27:34 DEBUG:zuul.Repo:Cloning from https://gerrit.wikimedia.org/r/p/mediawiki/skins/Vector to /workspace/src/skins/Vector
15:27:34 DEBUG:zuul.Repo:Resetting repository /workspace/src/skins/Vector
15:27:34 DEBUG:zuul.Repo:Updating repository /workspace/src/skins/Vector
15:27:35 INFO:zuul.Cloner:upstream repo has branch REL1_27
15:27:35 DEBUG:zuul.Cloner:Fetched ref REL1_27 from mediawiki/skins/Vector
15:27:35 DEBUG:zuul.Repo:Checking out bde9b1ae694ac45ffcf468c421f1b8c22a41f615
15:27:35 INFO:zuul.Cloner:Prepared mediawiki/skins/Vector repo with commit bde9b1ae694ac45ffcf468c421f1b8c22a41f615
15:27:35 INFO:zuul.Cloner:Creating repo mediawiki/extensions/BlueSpiceSubPageTree from upstream https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceSubPageTree
15:27:35 DEBUG:zuul.Repo:Cloning from https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceSubPageTree to /workspace/src/extensions/BlueSpiceSubPageTree
15:27:35 DEBUG:zuul.Repo:Resetting repository /workspace/src/extensions/BlueSpiceSubPageTree
15:27:35 DEBUG:zuul.Repo:Updating repository /workspace/src/extensions/BlueSpiceSubPageTree
15:27:36 INFO:zuul.Cloner:upstream repo has branch REL1_27
15:27:36 DEBUG:zuul.Cloner:Fetched ref REL1_27 from mediawiki/extensions/BlueSpiceSubPageTree
15:27:36 DEBUG:zuul.Repo:Checking out dfd9ce26976f62d7727732f806f3adaf05ed75c6
15:27:36 INFO:zuul.Cloner:Prepared mediawiki/extensions/BlueSpiceSubPageTree repo with commit dfd9ce26976f62d7727732f806f3adaf05ed75c6
15:27:36 INFO:zuul.Cloner:Creating repo mediawiki/extensions/BlueSpiceFoundation from upstream https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceFoundation
15:27:36 DEBUG:zuul.Repo:Cloning from https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceFoundation to /workspace/src/extensions/BlueSpiceFoundation
15:27:38 DEBUG:zuul.Repo:Resetting repository /workspace/src/extensions/BlueSpiceFoundation
15:27:38 DEBUG:zuul.Repo:Updating repository /workspace/src/extensions/BlueSpiceFoundation
15:27:38 INFO:zuul.Cloner:upstream repo has branch REL1_27
15:27:39 DEBUG:zuul.Cloner:Fetched ref REL1_27 from mediawiki/extensions/BlueSpiceFoundation
15:27:39 DEBUG:zuul.Repo:Checking out c766ab21a9dd4877526db52b153f02bf8fc75274
15:27:39 INFO:zuul.Cloner:Prepared mediawiki/extensions/BlueSpiceFoundation repo with commit c766ab21a9dd4877526db52b153f02bf8fc75274
15:27:39 INFO:zuul.Cloner:Prepared all repositories
15:27:39 INFO:quibble.cmd:Updating git submodules of extensions and skins
15:27:39 INFO:zuul.CloneMapper:Workspace path set to: ./
15:27:39 INFO:zuul.CloneMapper:Mapping projects to workspace...
15:27:39 INFO:zuul.CloneMapper:  mediawiki/extensions/BlueSpiceSubPageTree -> extensions/BlueSpiceSubPageTree
15:27:39 DEBUG:zuul.CloneMapper:Checking overlap in destination directories...
15:27:39 INFO:zuul.CloneMapper:Expansion completed.
15:27:39 WARNING:test.run_extskin:BlueSpiceSubPageTree lacks a composer.json
15:27:39 WARNING:test.run_extskin:BlueSpiceSubPageTree lacks a package.json
15:27:39 INFO:test.run_extskin:BlueSpiceSubPageTree: git clean -xqdf
15:27:39 INFO:quibble.cmd:composer.local.json for merge plugin
15:27:39 INFO:quibble.cmd:Created composer.local.json
15:27:39 INFO:quibble.cmd:Running "composer update for mediawiki/core
15:27:39 [6.3MB/0.01s] > pre-update-cmd: ComposerHookHandler::onPreUpdate
15:27:39 [6.3MB/0.01s] Loading composer repositories with package information
15:27:39 [6.6MB/0.16s] Updating dependencies (including require-dev)
15:27:47 [165.1MB/8.18s] Dependency resolution completed in 0.134 seconds
15:27:47 [165.2MB/8.19s] Analyzed 2212 packages to resolve dependencies
15:27:47 [165.2MB/8.19s] Analyzed 36735 rules to resolve dependencies
15:27:47 [166.0MB/8.21s] Dependency resolution completed in 0.000 seconds
15:27:47 [165.4MB/8.21s] Package operations: 51 installs, 0 updates, 0 removals
15:27:47 [165.4MB/8.21s] Installs: wikimedia/composer-merge-plugin:v1.3.1, composer/semver:1.4.0, cssjanus/cssjanus:v1.1.2, liuggio/statsd-php-client:v1.0.18, mediawiki/at-ease:v1.1.0, oojs/oojs-ui:v0.17.1, oyejorge/less.php:v1.7.0.10, wikimedia/assert:v0.2.2, wikimedia/base-convert:v1.0.1, wikimedia/cdb:1.3.0, wikimedia/cldr-plural-rule-parser:v1.0.0, wikimedia/html-formatter:1.0.1, wikimedia/ip-set:1.1.0, psr/log:1.0.0, wikimedia/php-session-serializer:v1.0.3, wikimedia/relpath:1.0.3, wikimedia/running-stat:v1.1.0, wikimedia/utfnormal:v1.0.3, wikimedia/wrappedstring:v2.0.0, zordius/lightncandy:v0.23, jakub-onderka/php-parallel-lint:v0.9.2, squizlabs/php_codesniffer:2.6.0, mediawiki/mediawiki-codesniffer:v0.7.2, monolog/monolog:1.18.2, nikic/php-parser:v1.4.1, nmred/kafka-php:v0.1.5, symfony/polyfill-ctype:v1.8.0, symfony/yaml:v3.4.11, sebastian/version:1.0.6, sebastian/global-state:1.1.1, sebastian/recursion-context:1.0.5, sebastian/exporter:1.2.2, sebastian/environment:1.3.8, sebastian/diff:1.4.3, sebastian/comparator:1.2.4, doctrine/instantiator:1.0.5, phpunit/php-text-template:1.2.1, phpunit/phpunit-mock-objects:2.3.8, phpunit/php-timer:1.0.9, phpunit/php-file-iterator:1.4.5, phpunit/php-token-stream:1.4.12, phpunit/php-code-coverage:2.2.4, webmozart/assert:1.3.0, phpdocumentor/reflection-common:1.0.1, phpdocumentor/type-resolver:0.4.0, phpdocumentor/reflection-docblock:4.3.0, phpspec/prophecy:1.7.6, phpunit/phpunit:4.8.36, wikimedia/testing-access-wrapper:1.0.0, wikimedia/avro:v1.7.7, justinrainbow/json-schema:1.6.1
15:27:48 [165.4MB/8.21s]   - Installing wikimedia/composer-merge-plugin (v1.3.1): [165.6MB/8.22s] Downloading[165.6MB/8.93s]  (100%)[165.6MB/8.93s] 
15:27:48 [165.6MB/8.93s]  Extracting archive[165.7MB/8.95s]   [merge-plugin] composer-merge-plugin installed
15:27:48 [165.7MB/8.95s]   - Installing composer/semver (1.4.0): [165.7MB/8.95s] Downloading[165.7MB/9.19s]  (100%)[165.7MB/9.20s] 
15:27:48 [165.7MB/9.20s]  Extracting archive[165.7MB/9.23s]   - Installing cssjanus/cssjanus (v1.1.2): [165.7MB/9.23s] Downloading[165.7MB/9.36s]  (100%)[165.7MB/9.36s] 
15:27:49 [165.7MB/9.36s]  Extracting archive[165.7MB/9.37s]   - Installing liuggio/statsd-php-client (v1.0.18): [165.7MB/9.37s] Downloading[165.7MB/9.51s]  (100%)[165.7MB/9.51s] 
15:27:49 [165.7MB/9.51s]  Extracting archive[165.7MB/9.52s]   - Installing mediawiki/at-ease (v1.1.0): [165.7MB/9.52s] Downloading[165.7MB/9.64s]  (100%)[165.7MB/9.64s] 
15:27:49 [165.7MB/9.64s]  Extracting archive[165.7MB/9.65s]   - Installing oojs/oojs-ui (v0.17.1): [165.7MB/9.65s] Downloading[165.7MB/9.79s]  (100%)[165.7MB/9.79s] 
15:27:49 [165.7MB/9.79s]  Extracting archive[165.7MB/9.82s]   - Installing oyejorge/less.php (v1.7.0.10): [165.7MB/9.82s] Downloading[165.7MB/9.96s]  (100%)[165.7MB/9.97s] 
15:27:49 [165.7MB/9.97s]  Extracting archive[165.7MB/9.99s]   - Installing wikimedia/assert (v0.2.2): [165.7MB/9.99s] Downloading[165.7MB/10.10s]  (100%)[165.7MB/10.10s] 
15:27:49 [165.7MB/10.10s]  Extracting archive[165.7MB/10.11s]   - Installing wikimedia/base-convert (v1.0.1): [165.7MB/10.12s] Downloading[165.7MB/10.29s]  (100%)[165.7MB/10.29s] 
15:27:50 [165.7MB/10.29s]  Extracting archive[165.7MB/10.30s]   - Installing wikimedia/cdb (1.3.0): [165.7MB/10.30s] Downloading[165.7MB/10.44s]  (100%)[165.7MB/10.44s] 
15:27:50 [165.7MB/10.44s]  Extracting archive[165.7MB/10.45s]   - Installing wikimedia/cldr-plural-rule-parser (v1.0.0): [165.7MB/10.45s] Downloading[165.7MB/10.57s]  (100%)[165.7MB/10.57s] 
15:27:50 [165.7MB/10.57s]  Extracting archive[165.7MB/10.58s]   - Installing wikimedia/html-formatter (1.0.1): [165.7MB/10.58s] Downloading[165.7MB/10.76s]  (100%)[165.7MB/10.76s] 
15:27:50 [165.7MB/10.76s]  Extracting archive[165.7MB/10.77s]   - Installing wikimedia/ip-set (1.1.0): [165.7MB/10.77s] Downloading[165.7MB/10.88s]  (100%)[165.7MB/10.88s] 
15:27:50 [165.7MB/10.88s]  Extracting archive[165.7MB/10.89s]   - Installing psr/log (1.0.0): [165.7MB/10.89s] Downloading[165.7MB/10.96s]  (100%)[165.7MB/10.96s] 
15:27:50 [165.7MB/10.96s]  Extracting archive[165.7MB/10.97s]   - Installing wikimedia/php-session-serializer (v1.0.3): [165.7MB/10.97s] Downloading[165.7MB/11.12s]  (100%)[165.7MB/11.12s] 
15:27:50 [165.7MB/11.12s]  Extracting archive[165.7MB/11.13s]   - Installing wikimedia/relpath (1.0.3): [165.7MB/11.13s] Downloading[165.7MB/11.24s]  (100%)[165.7MB/11.24s] 
15:27:50 [165.7MB/11.24s]  Extracting archive[165.7MB/11.25s]   - Installing wikimedia/running-stat (v1.1.0): [165.7MB/11.25s] Downloading[165.7MB/11.39s]  (100%)[165.7MB/11.39s] 
15:27:51 [165.7MB/11.39s]  Extracting archive[165.7MB/11.40s]   - Installing wikimedia/utfnormal (v1.0.3): [165.7MB/11.40s] Downloading[165.7MB/11.53s]  (100%)[165.7MB/11.53s] 
15:27:51 [165.7MB/11.53s]  Extracting archive[165.7MB/11.55s]   - Installing wikimedia/wrappedstring (v2.0.0): [165.7MB/11.55s] Downloading[165.7MB/11.67s]  (100%)[165.7MB/11.67s] 
15:27:51 [165.7MB/11.67s]  Extracting archive[165.7MB/11.68s]   - Installing zordius/lightncandy (v0.23): [165.7MB/11.68s] Downloading[165.7MB/11.81s]  (100%)[165.7MB/11.81s] 
15:27:51 [165.7MB/11.81s]  Extracting archive[165.7MB/11.82s]   - Installing jakub-onderka/php-parallel-lint (v0.9.2): [165.7MB/11.83s] Downloading[165.7MB/11.92s]  (100%)[165.7MB/11.92s] 
15:27:51 [165.7MB/11.92s]  Extracting archive[165.7MB/11.94s]   - Installing squizlabs/php_codesniffer (2.6.0): [165.7MB/11.94s] Downloading[165.7MB/12.16s]  (100%)[165.7MB/12.16s] 
15:27:51 [165.7MB/12.16s]  Extracting archive[165.7MB/12.23s]   - Installing mediawiki/mediawiki-codesniffer (v0.7.2): [165.7MB/12.23s] Downloading[165.7MB/12.37s]  (100%)[165.7MB/12.37s] 
15:27:52 [165.7MB/12.38s]  Extracting archive[165.7MB/12.40s]   - Installing monolog/monolog (1.18.2): [165.7MB/12.40s] Downloading[165.7MB/12.54s]  (100%)[165.7MB/12.54s] 
15:27:52 [165.7MB/12.54s]  Extracting archive[165.7MB/12.57s]   - Installing nikic/php-parser (v1.4.1): [165.7MB/12.57s] Downloading[165.7MB/12.70s]  (100%)[165.7MB/12.70s] 
15:27:52 [165.7MB/12.70s]  Extracting archive[165.7MB/12.75s]   - Installing nmred/kafka-php (v0.1.5): [165.7MB/12.75s] Downloading[165.7MB/12.88s]  (100%)[165.7MB/12.88s] 
15:27:52 [165.7MB/12.88s]  Extracting archive[165.7MB/12.89s]   - Installing symfony/polyfill-ctype (v1.8.0): [165.7MB/12.89s] Downloading[165.7MB/12.98s]  (100%)[165.7MB/12.98s] 
15:27:52 [165.7MB/12.98s]  Extracting archive[165.7MB/12.99s]   - Installing symfony/yaml (v3.4.11): [165.7MB/12.99s] Downloading[165.7MB/13.08s]  (100%)[165.7MB/13.08s] 
15:27:52 [165.7MB/13.08s]  Extracting archive[165.7MB/13.10s]   - Installing sebastian/version (1.0.6): [165.7MB/13.10s] Downloading[165.7MB/13.19s]  (100%)[165.7MB/13.19s] 
15:27:52 [165.7MB/13.19s]  Extracting archive[165.7MB/13.21s]   - Installing sebastian/global-state (1.1.1): [165.7MB/13.21s] Downloading[165.7MB/13.30s]  (100%)[165.7MB/13.30s] 
15:27:53 [165.7MB/13.31s]  Extracting archive[165.7MB/13.32s]   - Installing sebastian/recursion-context (1.0.5): [165.7MB/13.32s] Downloading[165.7MB/13.40s]  (100%)[165.7MB/13.40s] 
15:27:53 [165.7MB/13.40s]  Extracting archive[165.7MB/13.42s]   - Installing sebastian/exporter (1.2.2): [165.7MB/13.42s] Downloading[165.7MB/13.51s]  (100%)[165.7MB/13.51s] 
15:27:53 [165.7MB/13.51s]  Extracting archive[165.7MB/13.53s]   - Installing sebastian/environment (1.3.8): [165.7MB/13.53s] Downloading[165.7MB/13.62s]  (100%)[165.7MB/13.62s] 
15:27:53 [165.7MB/13.62s]  Extracting archive[165.7MB/13.63s]   - Installing sebastian/diff (1.4.3): [165.7MB/13.63s] Downloading[165.7MB/13.72s]  (100%)[165.7MB/13.72s] 
15:27:53 [165.7MB/13.72s]  Extracting archive[165.7MB/13.75s]   - Installing sebastian/comparator (1.2.4): [165.7MB/13.75s] Downloading[165.7MB/13.84s]  (100%)[165.7MB/13.84s] 
15:27:53 [165.7MB/13.84s]  Extracting archive[165.7MB/13.86s]   - Installing doctrine/instantiator (1.0.5): [165.7MB/13.86s] Downloading[165.7MB/13.94s]  (100%)[165.7MB/13.94s] 
15:27:53 [165.7MB/13.94s]  Extracting archive[165.7MB/13.96s]   - Installing phpunit/php-text-template (1.2.1): [165.7MB/13.96s] Downloading[165.7MB/14.04s]  (100%)[165.7MB/14.04s] 
15:27:53 [165.7MB/14.04s]  Extracting archive[165.7MB/14.05s]   - Installing phpunit/phpunit-mock-objects (2.3.8): [165.7MB/14.05s] Downloading[165.7MB/14.15s]  (100%)[165.7MB/14.15s] 
15:27:53 [165.7MB/14.15s]  Extracting archive[165.7MB/14.18s]   - Installing phpunit/php-timer (1.0.9): [165.7MB/14.18s] Downloading[165.7MB/14.30s]  (100%)[165.7MB/14.30s] 
15:27:54 [165.7MB/14.30s]  Extracting archive[165.7MB/14.31s]   - Installing phpunit/php-file-iterator (1.4.5): [165.7MB/14.31s] Downloading[165.7MB/14.40s]  (100%)[165.7MB/14.40s] 
15:27:54 [165.7MB/14.40s]  Extracting archive[165.7MB/14.41s]   - Installing phpunit/php-token-stream (1.4.12): [165.7MB/14.41s] Downloading[165.7MB/14.49s]  (100%)[165.7MB/14.50s] 
15:27:54 [165.7MB/14.50s]  Extracting archive[165.7MB/14.51s]   - Installing phpunit/php-code-coverage (2.2.4): [165.7MB/14.51s] Downloading[165.7MB/14.65s]  (100%)[165.7MB/14.65s] 
15:27:54 [165.7MB/14.65s]  Extracting archive[165.7MB/14.69s]   - Installing webmozart/assert (1.3.0): [165.7MB/14.69s] Downloading[165.7MB/14.77s]  (100%)[165.7MB/14.77s] 
15:27:54 [165.7MB/14.77s]  Extracting archive[165.7MB/14.78s]   - Installing phpdocumentor/reflection-common (1.0.1): [165.7MB/14.78s] Downloading[165.7MB/14.93s]  (100%)[165.7MB/14.93s] 
15:27:54 [165.7MB/14.93s]  Extracting archive[165.7MB/14.94s]   - Installing phpdocumentor/type-resolver (0.4.0): [165.7MB/14.94s] Downloading[165.7MB/15.03s]  (100%)[165.7MB/15.03s] 
15:27:54 [165.7MB/15.03s]  Extracting archive[165.7MB/15.05s]   - Installing phpdocumentor/reflection-docblock (4.3.0): [165.7MB/15.05s] Downloading[165.7MB/15.18s]  (100%)[165.7MB/15.18s] 
15:27:54 [165.7MB/15.18s]  Extracting archive[165.7MB/15.20s]   - Installing phpspec/prophecy (1.7.6): [165.7MB/15.20s] Downloading[165.7MB/15.35s]  (100%)[165.7MB/15.35s] 
15:27:55 [165.7MB/15.35s]  Extracting archive[165.7MB/15.37s]   - Installing phpunit/phpunit (4.8.36): [165.7MB/15.37s] Downloading[165.7MB/15.48s]  (100%)[165.7MB/15.48s] 
15:27:55 [165.7MB/15.48s]  Extracting archive[165.7MB/15.55s]   - Installing wikimedia/testing-access-wrapper (1.0.0): [165.7MB/15.55s] Downloading[165.7MB/15.69s]  (100%)[165.7MB/15.70s] 
15:27:55 [165.7MB/15.70s]  Extracting archive[165.7MB/15.71s]   - Installing wikimedia/avro (v1.7.7): [165.7MB/15.71s] Downloading[165.7MB/15.84s]  (100%)[165.7MB/15.84s] 
15:27:55 [165.7MB/15.84s]  Extracting archive[165.7MB/15.85s]   - Installing justinrainbow/json-schema (1.6.1): [165.7MB/15.85s] Downloading[165.7MB/15.95s]  (100%)[165.7MB/15.95s] 
15:27:55 [165.7MB/15.95s]  Extracting archive[148.1MB/16.18s] jakub-onderka/php-parallel-lint suggests installing jakub-onderka/php-console-highlighter (Highlight syntax in code snippet)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing aws/aws-sdk-php (Allow sending log messages to AWS services like DynamoDB)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing doctrine/couchdb (Allow sending log messages to a CouchDB server)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing ext-amqp (Allow sending log messages to an AMQP server (1.0+ required))
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing ext-mongo (Allow sending log messages to a MongoDB server)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing graylog2/gelf-php (Allow sending log messages to a GrayLog2 server)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing mongodb/mongodb (Allow sending log messages to a MongoDB server via PHP Driver)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing php-amqplib/php-amqplib (Allow sending log messages to an AMQP server using php-amqplib)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing php-console/php-console (Allow sending log messages to Google Chrome)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing raven/raven (Allow sending log messages to a Sentry server)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing rollbar/rollbar (Allow sending log messages to Rollbar)
15:27:55 [148.1MB/16.18s] monolog/monolog suggests installing ruflin/elastica (Allow sending log messages to an Elastic Search server)
15:27:55 [148.1MB/16.18s] symfony/yaml suggests installing symfony/console (For validating YAML files using the lint command)
15:27:55 [148.1MB/16.18s] sebastian/global-state suggests installing ext-uopz (*)
15:27:55 [148.1MB/16.18s] phpunit/phpunit-mock-objects suggests installing ext-soap (*)
15:27:55 [148.1MB/16.18s] phpunit/php-code-coverage suggests installing ext-xdebug (>=2.2.1)
15:27:55 [148.1MB/16.18s] phpunit/phpunit suggests installing phpunit/php-invoker (~1.1)
15:27:55 [148.1MB/16.18s] wikimedia/avro suggests installing ext-gmp (Large integer support for 32-bit platforms.)
15:27:55 [148.1MB/16.18s] Package mediawiki/at-ease is abandoned, you should avoid using it. Use wikimedia/at-ease instead.
15:27:55 [148.4MB/16.19s] Writing lock file
15:27:55 [148.4MB/16.19s] Generating optimized autoload files
15:27:55 [148.4MB/16.19s]   [merge-plugin] Loading composer.local.json...
15:27:55 [148.5MB/16.19s]   [merge-plugin] Loading extensions/BlueSpiceFoundation/composer.json...
15:27:55 [148.5MB/16.19s]   [merge-plugin] Merging param-processor/param-processor
15:27:56 [149.2MB/16.67s]   [merge-plugin] Running additional update to apply merge settings
15:27:56 [150.3MB/17.11s]   [merge-plugin] Loading composer.local.json...
15:27:56 [150.3MB/17.11s]   [merge-plugin] Loading extensions/BlueSpiceFoundation/composer.json...
15:27:56 [150.3MB/17.11s]   [merge-plugin] Merging param-processor/param-processor
15:27:56 [150.3MB/17.11s] > pre-update-cmd: ComposerHookHandler::onPreUpdate
15:27:56 [150.3MB/17.11s] Loading composer repositories with package information
15:27:56 [150.6MB/17.32s] Updating dependencies (including require-dev)
15:27:59 [309.3MB/19.83s] Dependency resolution completed in 0.221 seconds
15:27:59 [309.3MB/19.83s] Analyzed 2311 packages to resolve dependencies
15:27:59 [309.3MB/19.83s] Analyzed 37589 rules to resolve dependencies
15:27:59 [310.1MB/19.85s] Dependency resolution completed in 0.000 seconds
15:27:59 [309.5MB/19.85s] Package operations: 5 installs, 0 updates, 0 removals
15:27:59 [309.5MB/19.85s] Installs: data-values/interfaces:0.2.5, data-values/data-values:1.1.1, data-values/validators:0.1.2, data-values/common:0.4.1, param-processor/param-processor:1.3.4
15:27:59 [309.5MB/19.85s]   - Installing data-values/interfaces (0.2.5): [309.5MB/19.85s] Downloading (connecting...)[309.5MB/19.96s] [309.5MB/19.96s] Downloading (0%)[309.5MB/19.96s]                             [309.5MB/19.96s] [309.5MB/19.96s] [309.5MB/19.96s] Downloading (5%)[309.5MB/19.96s] [309.5MB/19.96s] Downloading (55%)[309.5MB/19.96s] [309.5MB/19.96s] Downloading (60%)[309.5MB/19.96s] [309.5MB/19.96s] Downloading (65%)[309.5MB/19.96s] [309.5MB/19.96s] Downloading (95%)[309.5MB/19.96s] [309.5MB/19.96s] Downloading (100%)[309.5MB/19.97s] 
15:27:59 [309.5MB/19.97s]  Extracting archive[309.5MB/19.99s]   - Installing data-values/data-values (1.1.1): [309.5MB/19.99s] Downloading (connecting...)[309.5MB/20.11s] [309.5MB/20.11s] Downloading (0%)[309.5MB/20.11s]                             [309.5MB/20.11s] [309.5MB/20.11s] [309.5MB/20.11s] Downloading (50%)[309.5MB/20.11s] [309.5MB/20.11s] Downloading (100%)[309.5MB/20.11s] 
15:27:59 [309.5MB/20.11s]  Extracting archive[309.5MB/20.13s]   - Installing data-values/validators (0.1.2): [309.5MB/20.13s] Downloading (connecting...)[309.5MB/20.25s] [309.5MB/20.25s] Downloading (0%)[309.5MB/20.25s]                             [309.5MB/20.25s] [309.5MB/20.25s] [309.5MB/20.25s] Downloading (50%)[309.5MB/20.25s] [309.5MB/20.25s] Downloading (85%)[309.5MB/20.25s] [309.5MB/20.25s] Downloading (100%)[309.5MB/20.25s] 
15:28:00 [309.5MB/20.25s]  Extracting archive[309.5MB/20.26s]   - Installing data-values/common (0.4.1): [309.5MB/20.26s] Downloading (connecting...)[309.5MB/20.40s] [309.5MB/20.40s] Downloading (0%)[309.5MB/20.40s]                             [309.5MB/20.40s] [309.5MB/20.40s] [309.5MB/20.40s] Downloading (20%)[309.5MB/20.40s] [309.5MB/20.40s] Downloading (45%)[309.5MB/20.40s] [309.5MB/20.40s] Downloading (70%)[309.5MB/20.40s] [309.5MB/20.40s] Downloading (75%)[309.5MB/20.40s] [309.5MB/20.40s] Downloading (85%)[309.5MB/20.40s] [309.5MB/20.40s] Downloading (90%)[309.5MB/20.40s] [309.5MB/20.40s] Downloading (100%)[309.5MB/20.40s] 
15:28:00 [309.5MB/20.40s]  Extracting archive[309.5MB/20.42s]   - Installing param-processor/param-processor (1.3.4): [309.5MB/20.42s] Downloading (connecting...)[309.5MB/20.56s] [309.5MB/20.56s] Downloading (0%)[309.5MB/20.56s]                             [309.5MB/20.56s] [309.5MB/20.56s] [309.5MB/20.56s] Downloading (5%)[309.5MB/20.56s] [309.5MB/20.56s] Downloading (35%)[309.5MB/20.56s] [309.5MB/20.56s] Downloading (100%)[309.5MB/20.56s] 
15:28:00 [309.5MB/20.56s]  Extracting archive[291.3MB/20.83s] Package mediawiki/at-ease is abandoned, you should avoid using it. Use wikimedia/at-ease instead.
15:28:00 [291.7MB/20.85s] Writing lock file
15:28:00 [291.7MB/20.85s] Generating optimized autoload files
15:28:00 [291.8MB/21.35s] > post-update-cmd: ComposerVendorHtaccessCreator::onEvent
15:28:01 [291.9MB/21.48s] > post-update-cmd: ComposerVendorHtaccessCreator::onEvent
15:28:01 [291.8MB/21.48s] Memory usage: 291.84MB (peak: 310.11MB), time: 21.48s
15:28:01 INFO:backend.MySQL:Initializing MySQL data directory
15:28:11 INFO:backend.MySQL:Starting MySQL
15:28:11 INFO:backend.MySQL:Waiting for MySQL socket
15:28:12 INFO:backend.MySQL:Creating the wiki database and grant
15:28:12 INFO:backend.MySQL:MySQL is ready
15:28:12 setup-docker-quibble-mw-and-npmShow Details
INFO:mw.maintenance.install:php maintenance/install.php --scriptpath= --dbtype=mysql --dbname=wikidb --dbuser=wikiuser --dbpass=secret --dbserver=localhost:/tmp/quibble-mysql-89mojr6o/socket --with-extensions --pass=testpass TestWiki WikiAdmin
15:28:12 PHP 7.0.27-0+deb9u1 is installed.
15:28:12 Found ImageMagick: /usr/bin/convert.
15:28:12 Image thumbnailing will be enabled if you enable uploads.
15:28:12 Found the Git version control software: /usr/bin/git.
15:28:12 Using server URL "".
15:28:12 Warning: Your default directory for uploads (/workspace/src/images/) is not checked for vulnerability
15:28:12 to arbitrary script execution during the CLI install.
15:28:12 Using the intl PECL extension for Unicode normalization.
15:28:12 The environment has been checked.
15:28:12 You can install MediaWiki.
15:28:12 Including extensions
15:28:12 done
15:28:12 Setting up database
15:28:12 done
15:28:12 Creating tables
15:28:14 done
15:28:14 Creating database user
15:28:14 done
15:28:14 Populating default interwiki table
15:28:14 done
15:28:14 Initializing statistics
15:28:14 done
15:28:14 Generating secret keys
15:28:14 done
15:28:14 Prevent running unneeded updates
15:28:14 done
15:28:14 Creating administrator user account
15:28:14 done
15:28:14 Creating main page with default content
15:28:14 done
15:28:14 Creating tables for enabled extensions
15:28:14 done
15:28:14 Proceeding '00_dev_settings.php'...
15:28:14 Proceeding '10_env_mw_install_path.php'...
15:28:14 Proceeding '10_set_wgEnableJavaScriptTest.php'...
15:28:14 Proceeding '10_set_wgWikimediaJenkinsCI.php'...
15:28:14 Proceeding '20_set_wgdjvu.php'...
15:28:14 No syntax errors detected in /workspace/src/LocalSettings.php
15:28:14 INFO:quibble.cmd:Copying /workspace/src/LocalSettings.php to /log/LocalSettings.php
15:28:14 INFO:mw.maintenance.update:php maintenance/update.php --quick
15:28:14 MediaWiki 1.27.4 Updater
15:28:14 
15:28:14 Your composer.lock file is up to date with current dependencies!
15:28:14 Going to run database updates for wikidb
15:28:14 Depending on the size of your database this may take a while!
15:28:14 Turning off Content Handler DB fields for this part of upgrade.
15:28:14 ...have ipb_id field in ipblocks table.
15:28:14 ...have ipb_expiry field in ipblocks table.
15:28:14 ...already have interwiki table
15:28:14 ...indexes seem up to 20031107 standards.
15:28:14 ...have rc_type field in recentchanges table.
15:28:14 ...index new_name_timestamp already set on recentchanges table.
15:28:14 ...have user_real_name field in user table.
15:28:14 ...querycache table already exists.
15:28:14 ...objectcache table already exists.
15:28:14 ...categorylinks table already exists.
15:28:14 ...have pagelinks; skipping old links table updates
15:28:14 ...il_from OK
15:28:14 ...have rc_ip field in recentchanges table.
15:28:14 ...index PRIMARY already set on image table.
15:28:14 ...have rc_id field in recentchanges table.
15:28:14 ...have rc_patrolled field in recentchanges table.
15:28:14 ...logging table already exists.
15:28:14 ...have user_token field in user table.
15:28:14 ...have wl_notificationtimestamp field in watchlist table.
15:28:14 ...watchlist talk page rows already present.
15:28:14 ...user table does not contain user_emailauthenticationtimestamp field.
15:28:14 ...page table already exists.
15:28:14 ...have log_params field in logging table.
15:28:14 ...logging table has correct log_title encoding.
15:28:14 ...have ar_rev_id field in archive table.
15:28:14 ...have page_len field in page table.
15:28:14 ...revision table does not contain inverse_timestamp field.
15:28:14 ...have rev_text_id field in revision table.
15:28:14 ...have rev_deleted field in revision table.
15:28:14 ...have img_width field in image table.
15:28:14 ...have img_metadata field in image table.
15:28:14 ...have user_email_token field in user table.
15:28:14 ...have ar_text_id field in archive table.
15:28:14 ...page_namespace is already a full int (int(11)).
15:28:14 ...ar_namespace is already a full int (int(11)).
15:28:14 ...rc_namespace is already a full int (int(11)).
15:28:14 ...wl_namespace is already a full int (int(11)).
15:28:14 ...qc_namespace is already a full int (int(11)).
15:28:14 ...log_namespace is already a full int (int(11)).
15:28:14 ...have img_media_type field in image table.
15:28:14 ...already have pagelinks table.
15:28:14 ...image table does not contain img_type field.
15:28:14 ...already have unique user_name index.
15:28:14 ...user_groups table exists and is in current format.
15:28:14 ...have ss_total_pages field in site_stats table.
15:28:14 ...user_newtalk table already exists.
15:28:14 ...transcache table already exists.
15:28:14 ...have iw_trans field in interwiki table.
15:28:14 ...wl_notificationtimestamp is already nullable.
15:28:14 ...index times already set on logging table.
15:28:14 ...have ipb_range_start field in ipblocks table.
15:28:14 ...no page_random rows needed to be set
15:28:14 ...have user_registration field in user table.
15:28:14 ...templatelinks table already exists
15:28:14 ...externallinks table already exists.
15:28:14 ...job table already exists.
15:28:14 ...have ss_images field in site_stats table.
15:28:14 ...langlinks table already exists.
15:28:14 ...querycache_info table already exists.
15:28:14 ...filearchive table already exists.
15:28:14 ...have ipb_anon_only field in ipblocks table.
15:28:14 ...index rc_ns_usertext already set on recentchanges table.
15:28:14 ...index rc_user_text already set on recentchanges table.
15:28:14 ...have user_newpass_time field in user table.
15:28:14 ...redirect table already exists.
15:28:14 ...querycachetwo table already exists.
15:28:14 ...have ipb_enable_autoblock field in ipblocks table.
15:28:14 ...index pl_namespace on table pagelinks includes field pl_from.
15:28:14 ...index tl_namespace on table templatelinks includes field tl_from.
15:28:14 ...index il_to on table imagelinks includes field il_from.
15:28:14 ...have rc_old_len field in recentchanges table.
15:28:14 ...have user_editcount field in user table.
15:28:14 ...page_restrictions table already exists.
15:28:14 ...have log_id field in logging table.
15:28:14 ...have rev_parent_id field in revision table.
15:28:14 ...have pr_id field in page_restrictions table.
15:28:14 ...have rev_len field in revision table.
15:28:14 ...have rc_deleted field in recentchanges table.
15:28:14 ...have log_deleted field in logging table.
15:28:14 ...have ar_deleted field in archive table.
15:28:14 ...have ipb_deleted field in ipblocks table.
15:28:14 ...have fa_deleted field in filearchive table.
15:28:14 ...have ar_len field in archive table.
15:28:14 ...have ipb_block_email field in ipblocks table.
15:28:14 ...index cl_sortkey on table categorylinks includes field cl_from.
15:28:14 ...have oi_metadata field in oldimage table.
15:28:14 ...index usertext_timestamp already set on archive table.
15:28:14 ...index img_usertext_timestamp already set on image table.
15:28:14 ...index oi_usertext_timestamp already set on oldimage table.
15:28:14 ...have ar_page_id field in archive table.
15:28:14 ...have img_sha1 field in image table.
15:28:14 ...protected_titles table already exists.
15:28:14 ...have ipb_by_text field in ipblocks table.
15:28:14 ...page_props table already exists.
15:28:14 ...updatelog table already exists.
15:28:14 ...category table already exists.
15:28:14 Populating category table, printing progress markers. For large databases, you
15:28:14 may want to hit Ctrl-C and do this manually with maintenance/
15:28:14 populateCategory.php.
15:28:14 Category population complete.
15:28:14 Done populating category table.
15:28:14 ...have ar_parent_id field in archive table.
15:28:14 ...have user_last_timestamp field in user_newtalk table.
15:28:14 Populating rev_parent_id fields, printing progress markers. For large
15:28:14 databases, you may want to hit Ctrl-C and do this manually with
15:28:14 maintenance/populateParentId.php.
15:28:14 Populating rev_parent_id column
15:28:14 ...doing rev_id from 1 to 200
15:28:14 rev_parent_id population complete ... 0 rows [0 changed]
15:28:14 ...protected_titles table has correct pt_title encoding.
15:28:14 ...have ss_active_users field in site_stats table.
15:28:14 ...ss_active_users user count set...
15:28:14 ...have ipb_allow_usertalk field in ipblocks table.
15:28:14 Making pl_namespace, tl_namespace and il_to indices UNIQUE ...done.
15:28:14 ...change_tag table already exists.
15:28:14 ...tag_summary table already exists.
15:28:14 ...valid_tag table already exists.
15:28:14 ...user_properties table already exists.
15:28:14 ...log_search table already exists.
15:28:14 ...have log_user_text field in logging table.
15:28:14 Populating log_user_text field, printing progress markers. For large
15:28:14 databases, you may want to hit Ctrl-C and do this manually with
15:28:14 maintenance/populateLogUsertext.php.
15:28:14 Nothing to do.
15:28:14 done.
15:28:14 Populating log_search table, printing progress markers. For large
15:28:14 databases, you may want to hit Ctrl-C and do this manually with
15:28:14 maintenance/populateLogSearch.php.
15:28:14 Nothing to do.
15:28:14 done.
15:28:14 ...l10n_cache table already exists.
15:28:14 ...index ls_field_val already set on log_search table.
15:28:14 ...index change_tag_rc_tag already set on change_tag table.
15:28:14 ...have rd_interwiki field in redirect table.
15:28:14 Converting tc_time from UNIX epoch to MediaWiki timestamp ...done.
15:28:14 Altering all *_mime_minor fields to 100 bytes in size ...done.
15:28:14 ...iwlinks table already exists.
15:28:14 ...index iwl_prefix_title_from already set on iwlinks table.
15:28:14 ...have ul_value field in updatelog table.
15:28:14 ...have iw_api field in interwiki table.
15:28:14 ...iwl_prefix key doesn't exist.
15:28:14 ...have cl_collation field in categorylinks table.
15:28:14 Updating categorylinks (again) ...done.
15:28:14 ...module_deps table already exists.
15:28:14 ...ar_page_revid key doesn't exist.
15:28:14 ...index ar_revid already set on archive table.
15:28:14 ...ll_lang is up-to-date.
15:28:14 ...user_last_timestamp is already nullable.
15:28:14 ...index user_email already set on user table.
15:28:14 ...up_property in table user_properties already modified by patch patch-up_property.sql.
15:28:14 ...uploadstash table already exists.
15:28:14 ...user_former_groups table already exists.
15:28:14 ...index type_action already set on logging table.
15:28:14 ...have rev_sha1 field in revision table.
15:28:14 ...batch conversion of user_options: nothing to migrate. done.
15:28:14 ...user table does not contain user_options field.
15:28:14 ...have ar_sha1 field in archive table.
15:28:14 ...index page_redirect_namespace_len already set on page table.
15:28:14 ...have us_chunk_inx field in uploadstash table.
15:28:14 ...have job_timestamp field in job table.
15:28:14 ...index page_user_timestamp already set on revision table.
15:28:14 ...have ipb_parent_block_id field in ipblocks table.
15:28:14 ...index ipb_parent_block_id already set on ipblocks table.
15:28:14 ...category table does not contain cat_hidden field.
15:28:14 ...have rev_content_format field in revision table.
15:28:14 ...have rev_content_model field in revision table.
15:28:14 ...have ar_content_format field in archive table.
15:28:14 ...have ar_content_model field in archive table.
15:28:14 ...have page_content_model field in page table.
15:28:14 Content Handler DB fields should be usable now.
15:28:14 ...site_stats table does not contain ss_admins field.
15:28:14 ...recentchanges table does not contain rc_moved_to_title field.
15:28:14 ...sites table already exists.
15:28:14 ...have fa_sha1 field in filearchive table.
15:28:14 ...have job_token field in job table.
15:28:14 ...have job_attempts field in job table.
15:28:14 ...have us_props field in uploadstash table.
15:28:14 ...ug_group in table user_groups already modified by patch patch-ug_group-length-increase-255.sql.
15:28:14 ...ufg_group in table user_former_groups already modified by patch patch-ufg_group-length-increase-255.sql.
15:28:14 ...index pp_propname_page already set on page_props table.
15:28:14 ...index img_media_mime already set on image table.
15:28:14 ...iwl_prefix_title_from index is already non-UNIQUE.
15:28:14 ...index iwl_prefix_from_title already set on iwlinks table.
15:28:14 ...have ar_id field in archive table.
15:28:14 ...have el_id field in externallinks table.
15:28:14 ...have rc_source field in recentchanges table.
15:28:14 ...index log_user_text_type_time already set on logging table.
15:28:14 ...index log_user_text_time already set on logging table.
15:28:14 ...have page_links_updated field in page table.
15:28:14 ...have user_password_expires field in user table.
15:28:14 ...have pp_sortkey field in page_props table.
15:28:14 ...recentchanges table does not contain rc_cur_time field.
15:28:14 ...index wl_user_notificationtimestamp already set on watchlist table.
15:28:14 ...have page_lang field in page table.
15:28:14 ...have pl_from_namespace field in pagelinks table.
15:28:14 ...have tl_from_namespace field in templatelinks table.
15:28:14 ...have il_from_namespace field in imagelinks table.
15:28:14 ...img_major_mime in table image already modified by patch patch-img_major_mime-chemical.sql.
15:28:14 ...oi_major_mime in table oldimage already modified by patch patch-oi_major_mime-chemical.sql.
15:28:14 ...fa_major_mime in table filearchive already modified by patch patch-fa_major_mime-chemical.sql.
15:28:14 ...user_id is already unsigned int.
15:28:14 Modifying rc_comment field of table recentchanges ...done.
15:28:14 ...hitcounter doesn't exist.
15:28:14 ...site_stats table does not contain ss_total_views field.
15:28:14 ...page table does not contain page_counter field.
15:28:14 ...msg_resource_links doesn't exist.
15:28:14 ...msg_resource doesn't exist.
15:28:14 ...bot_passwords table already exists.
15:28:14 ...have wl_id field in watchlist table.
15:28:14 ...cl_collation key doesn't exist.
15:28:14 ...index cl_collation_ext already set on categorylinks table.
15:28:14 ...collations up-to-date.
15:28:14 ...site_stats is populated...done.
15:28:14 A database query error has occurred.
15:28:14 Query: INSERT  INTO `updatelog` (ul_key,ul_value) VALUES ('updatelist-1.27.4-15295948940','a:192:{i:0;a:1:{i:0;s:26:\"disableContentHandlerUseDB\";}i:1;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:6:\"ipb_id\";i:3;s:18:\"patch-ipblocks.sql\";}i:2;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:10:\"ipb_expiry\";i:3;s:20:\"patch-ipb_expiry.sql\";}i:3;a:1:{i:0;s:17:\"doInterwikiUpdate\";}i:4;a:1:{i:0;s:13:\"doIndexUpdate\";}i:5;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"recentchanges\";i:2;s:7:\"rc_type\";i:3;s:17:\"patch-rc_type.sql\";}i:6;a:4:{i:0;s:8:\"addIndex\";i:1;s:13:\"recentchanges\";i:2;s:18:\"new_name_timestamp\";i:3;s:21:\"patch-rc-newindex.sql\";}i:7;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"user\";i:2;s:14:\"user_real_name\";i:3;s:23:\"patch-user-realname.sql\";}i:8;a:3:{i:0;s:8:\"addTable\";i:1;s:10:\"querycache\";i:2;s:20:\"patch-querycache.sql\";}i:9;a:3:{i:0;s:8:\"addTable\";i:1;s:11:\"objectcache\";i:2;s:21:\"patch-objectcache.sql\";}i:10;a:3:{i:0;s:8:\"addTable\";i:1;s:13:\"categorylinks\";i:2;s:23:\"patch-categorylinks.sql\";}i:11;a:1:{i:0;s:16:\"doOldLinksUpdate\";}i:12;a:1:{i:0;s:22:\"doFixAncientImagelinks\";}i:13;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"recentchanges\";i:2;s:5:\"rc_ip\";i:3;s:15:\"patch-rc_ip.sql\";}i:14;a:4:{i:0;s:8:\"addIndex\";i:1;s:5:\"image\";i:2;s:7:\"PRIMARY\";i:3;s:28:\"patch-image_name_primary.sql\";}i:15;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"recentchanges\";i:2;s:5:\"rc_id\";i:3;s:15:\"patch-rc_id.sql\";}i:16;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"recentchanges\";i:2;s:12:\"rc_patrolled\";i:3;s:19:\"patch-rc-patrol.sql\";}i:17;a:3:{i:0;s:8:\"addTable\";i:1;s:7:\"logging\";i:2;s:17:\"patch-logging.sql\";}i:18;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"user\";i:2;s:10:\"user_token\";i:3;s:20:\"patch-user_token.sql\";}i:19;a:4:{i:0;s:8:\"addField\";i:1;s:9:\"watchlist\";i:2;s:24:\"wl_notificationtimestamp\";i:3;s:28:\"patch-email-notification.sql\";}i:20;a:1:{i:0;s:17:\"doWatchlistUpdate\";}i:21;a:4:{i:0;s:9:\"dropField\";i:1;s:4:\"user\";i:2;s:33:\"user_emailauthenticationtimestamp\";i:3;s:30:\"patch-email-authentication.sql\";}i:22;a:1:{i:0;s:21:\"doSchemaRestructuring\";}i:23;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"logging\";i:2;s:10:\"log_params\";i:3;s:20:\"patch-log_params.sql\";}i:24;a:4:{i:0;s:8:\"checkBin\";i:1;s:7:\"logging\";i:2;s:9:\"log_title\";i:3;s:23:\"patch-logging-title.sql\";}i:25;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:9:\"ar_rev_id\";i:3;s:24:\"patch-archive-rev_id.sql\";}i:26;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"page\";i:2;s:8:\"page_len\";i:3;s:18:\"patch-page_len.sql\";}i:27;a:4:{i:0;s:9:\"dropField\";i:1;s:8:\"revision\";i:2;s:17:\"inverse_timestamp\";i:3;s:27:\"patch-inverse_timestamp.sql\";}i:28;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"revision\";i:2;s:11:\"rev_text_id\";i:3;s:21:\"patch-rev_text_id.sql\";}i:29;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"revision\";i:2;s:11:\"rev_deleted\";i:3;s:21:\"patch-rev_deleted.sql\";}i:30;a:4:{i:0;s:8:\"addField\";i:1;s:5:\"image\";i:2;s:9:\"img_width\";i:3;s:19:\"patch-img_width.sql\";}i:31;a:4:{i:0;s:8:\"addField\";i:1;s:5:\"image\";i:2;s:12:\"img_metadata\";i:3;s:22:\"patch-img_metadata.sql\";}i:32;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"user\";i:2;s:16:\"user_email_token\";i:3;s:26:\"patch-user_email_token.sql\";}i:33;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:10:\"ar_text_id\";i:3;s:25:\"patch-archive-text_id.sql\";}i:34;a:1:{i:0;s:15:\"doNamespaceSize\";}i:35;a:4:{i:0;s:8:\"addField\";i:1;s:5:\"image\";i:2;s:14:\"img_media_type\";i:3;s:24:\"patch-img_media_type.sql\";}i:36;a:1:{i:0;s:17:\"doPagelinksUpdate\";}i:37;a:4:{i:0;s:9:\"dropField\";i:1;s:5:\"image\";i:2;s:8:\"img_type\";i:3;s:23:\"patch-drop_img_type.sql\";}i:38;a:1:{i:0;s:18:\"doUserUniqueUpdate\";}i:39;a:1:{i:0;s:18:\"doUserGroupsUpdate\";}i:40;a:4:{i:0;s:8:\"addField\";i:1;s:10:\"site_stats\";i:2;s:14:\"ss_total_pages\";i:3;s:27:\"patch-ss_total_articles.sql\";}i:41;a:3:{i:0;s:8:\"addTable\";i:1;s:12:\"user_newtalk\";i:2;s:22:\"patch-usernewtalk2.sql\";}i:42;a:3:{i:0;s:8:\"addTable\";i:1;s:10:\"transcache\";i:2;s:20:\"patch-transcache.sql\";}i:43;a:4:{i:0;s:8:\"addField\";i:1;s:9:\"interwiki\";i:2;s:8:\"iw_trans\";i:3;s:25:\"patch-interwiki-trans.sql\";}i:44;a:1:{i:0;s:15:\"doWatchlistNull\";}i:45;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"logging\";i:2;s:5:\"times\";i:3;s:29:\"patch-logging-times-index.sql\";}i:46;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:15:\"ipb_range_start\";i:3;s:25:\"patch-ipb_range_start.sql\";}i:47;a:1:{i:0;s:18:\"doPageRandomUpdate\";}i:48;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"user\";i:2;s:17:\"user_registration\";i:3;s:27:\"patch-user_registration.sql\";}i:49;a:1:{i:0;s:21:\"doTemplatelinksUpdate\";}i:50;a:3:{i:0;s:8:\"addTable\";i:1;s:13:\"externallinks\";i:2;s:23:\"patch-externallinks.sql\";}i:51;a:3:{i:0;s:8:\"addTable\";i:1;s:3:\"job\";i:2;s:13:\"patch-job.sql\";}i:52;a:4:{i:0;s:8:\"addField\";i:1;s:10:\"site_stats\";i:2;s:9:\"ss_images\";i:3;s:19:\"patch-ss_images.sql\";}i:53;a:3:{i:0;s:8:\"addTable\";i:1;s:9:\"langlinks\";i:2;s:19:\"patch-langlinks.sql\";}i:54;a:3:{i:0;s:8:\"addTable\";i:1;s:15:\"querycache_info\";i:2;s:24:\"patch-querycacheinfo.sql\";}i:55;a:3:{i:0;s:8:\"addTable\";i:1;s:11:\"filearchive\";i:2;s:21:\"patch-filearchive.sql\";}i:56;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:13:\"ipb_anon_only\";i:3;s:23:\"patch-ipb_anon_only.sql\";}i:57;a:4:{i:0;s:8:\"addIndex\";i:1;s:13:\"recentchanges\";i:2;s:14:\"rc_ns_usertext\";i:3;s:31:\"patch-recentchanges-utindex.sql\";}i:58;a:4:{i:0;s:8:\"addIndex\";i:1;s:13:\"recentchanges\";i:2;s:12:\"rc_user_text\";i:3;s:28:\"patch-rc_user_text-index.sql\";}i:59;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"user\";i:2;s:17:\"user_newpass_time\";i:3;s:27:\"patch-user_newpass_time.sql\";}i:60;a:3:{i:0;s:8:\"addTable\";i:1;s:8:\"redirect\";i:2;s:18:\"patch-redirect.sql\";}i:61;a:3:{i:0;s:8:\"addTable\";i:1;s:13:\"querycachetwo\";i:2;s:23:\"patch-querycachetwo.sql\";}i:62;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:20:\"ipb_enable_autoblock\";i:3;s:32:\"patch-ipb_optional_autoblock.sql\";}i:63;a:1:{i:0;s:26:\"doBacklinkingIndicesUpdate\";}i:64;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"recentchanges\";i:2;s:10:\"rc_old_len\";i:3;s:16:\"patch-rc_len.sql\";}i:65;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"user\";i:2;s:14:\"user_editcount\";i:3;s:24:\"patch-user_editcount.sql\";}i:66;a:1:{i:0;s:20:\"doRestrictionsUpdate\";}i:67;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"logging\";i:2;s:6:\"log_id\";i:3;s:16:\"patch-log_id.sql\";}i:68;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"revision\";i:2;s:13:\"rev_parent_id\";i:3;s:23:\"patch-rev_parent_id.sql\";}i:69;a:4:{i:0;s:8:\"addField\";i:1;s:17:\"page_restrictions\";i:2;s:5:\"pr_id\";i:3;s:35:\"patch-page_restrictions_sortkey.sql\";}i:70;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"revision\";i:2;s:7:\"rev_len\";i:3;s:17:\"patch-rev_len.sql\";}i:71;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"recentchanges\";i:2;s:10:\"rc_deleted\";i:3;s:20:\"patch-rc_deleted.sql\";}i:72;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"logging\";i:2;s:11:\"log_deleted\";i:3;s:21:\"patch-log_deleted.sql\";}i:73;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:10:\"ar_deleted\";i:3;s:20:\"patch-ar_deleted.sql\";}i:74;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:11:\"ipb_deleted\";i:3;s:21:\"patch-ipb_deleted.sql\";}i:75;a:4:{i:0;s:8:\"addField\";i:1;s:11:\"filearchive\";i:2;s:10:\"fa_deleted\";i:3;s:20:\"patch-fa_deleted.sql\";}i:76;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:6:\"ar_len\";i:3;s:16:\"patch-ar_len.sql\";}i:77;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:15:\"ipb_block_email\";i:3;s:22:\"patch-ipb_emailban.sql\";}i:78;a:1:{i:0;s:28:\"doCategorylinksIndicesUpdate\";}i:79;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"oldimage\";i:2;s:11:\"oi_metadata\";i:3;s:21:\"patch-oi_metadata.sql\";}i:80;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"archive\";i:2;s:18:\"usertext_timestamp\";i:3;s:28:\"patch-archive-user-index.sql\";}i:81;a:4:{i:0;s:8:\"addIndex\";i:1;s:5:\"image\";i:2;s:22:\"img_usertext_timestamp\";i:3;s:26:\"patch-image-user-index.sql\";}i:82;a:4:{i:0;s:8:\"addIndex\";i:1;s:8:\"oldimage\";i:2;s:21:\"oi_usertext_timestamp\";i:3;s:29:\"patch-oldimage-user-index.sql\";}i:83;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:10:\"ar_page_id\";i:3;s:25:\"patch-archive-page_id.sql\";}i:84;a:4:{i:0;s:8:\"addField\";i:1;s:5:\"image\";i:2;s:8:\"img_sha1\";i:3;s:18:\"patch-img_sha1.sql\";}i:85;a:3:{i:0;s:8:\"addTable\";i:1;s:16:\"protected_titles\";i:2;s:26:\"patch-protected_titles.sql\";}i:86;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:11:\"ipb_by_text\";i:3;s:21:\"patch-ipb_by_text.sql\";}i:87;a:3:{i:0;s:8:\"addTable\";i:1;s:10:\"page_props\";i:2;s:20:\"patch-page_props.sql\";}i:88;a:3:{i:0;s:8:\"addTable\";i:1;s:9:\"updatelog\";i:2;s:19:\"patch-updatelog.sql\";}i:89;a:3:{i:0;s:8:\"addTable\";i:1;s:8:\"category\";i:2;s:18:\"patch-category.sql\";}i:90;a:1:{i:0;s:20:\"doCategoryPopulation\";}i:91;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:12:\"ar_parent_id\";i:3;s:22:\"patch-ar_parent_id.sql\";}i:92;a:4:{i:0;s:8:\"addField\";i:1;s:12:\"user_newtalk\";i:2;s:19:\"user_last_timestamp\";i:3;s:29:\"patch-user_last_timestamp.sql\";}i:93;a:1:{i:0;s:18:\"doPopulateParentId\";}i:94;a:4:{i:0;s:8:\"checkBin\";i:1;s:16:\"protected_titles\";i:2;s:8:\"pt_title\";i:3;s:27:\"patch-pt_title-encoding.sql\";}i:95;a:1:{i:0;s:28:\"doMaybeProfilingMemoryUpdate\";}i:96;a:1:{i:0;s:26:\"doFilearchiveIndicesUpdate\";}i:97;a:4:{i:0;s:8:\"addField\";i:1;s:10:\"site_stats\";i:2;s:15:\"ss_active_users\";i:3;s:25:\"patch-ss_active_users.sql\";}i:98;a:1:{i:0;s:17:\"doActiveUsersInit\";}i:99;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:18:\"ipb_allow_usertalk\";i:3;s:28:\"patch-ipb_allow_usertalk.sql\";}i:100;a:1:{i:0;s:14:\"doUniquePlTlIl\";}i:101;a:3:{i:0;s:8:\"addTable\";i:1;s:10:\"change_tag\";i:2;s:20:\"patch-change_tag.sql\";}i:102;a:3:{i:0;s:8:\"addTable\";i:1;s:11:\"tag_summary\";i:2;s:21:\"patch-tag_summary.sql\";}i:103;a:3:{i:0;s:8:\"addTable\";i:1;s:9:\"valid_tag\";i:2;s:19:\"patch-valid_tag.sql\";}i:104;a:3:{i:0;s:8:\"addTable\";i:1;s:15:\"user_properties\";i:2;s:25:\"patch-user_properties.sql\";}i:105;a:3:{i:0;s:8:\"addTable\";i:1;s:10:\"log_search\";i:2;s:20:\"patch-log_search.sql\";}i:106;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"logging\";i:2;s:13:\"log_user_text\";i:3;s:23:\"patch-log_user_text.sql\";}i:107;a:1:{i:0;s:23:\"doLogUsertextPopulation\";}i:108;a:1:{i:0;s:21:\"doLogSearchPopulation\";}i:109;a:3:{i:0;s:8:\"addTable\";i:1;s:10:\"l10n_cache\";i:2;s:20:\"patch-l10n_cache.sql\";}i:110;a:4:{i:0;s:8:\"addIndex\";i:1;s:10:\"log_search\";i:2;s:12:\"ls_field_val\";i:3;s:33:\"patch-log_search-rename-index.sql\";}i:111;a:4:{i:0;s:8:\"addIndex\";i:1;s:10:\"change_tag\";i:2;s:17:\"change_tag_rc_tag\";i:3;s:28:\"patch-change_tag-indexes.sql\";}i:112;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"redirect\";i:2;s:12:\"rd_interwiki\";i:3;s:22:\"patch-rd_interwiki.sql\";}i:113;a:1:{i:0;s:23:\"doUpdateTranscacheField\";}i:114;a:1:{i:0;s:22:\"doUpdateMimeMinorField\";}i:115;a:3:{i:0;s:8:\"addTable\";i:1;s:7:\"iwlinks\";i:2;s:17:\"patch-iwlinks.sql\";}i:116;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"iwlinks\";i:2;s:21:\"iwl_prefix_title_from\";i:3;s:27:\"patch-rename-iwl_prefix.sql\";}i:117;a:4:{i:0;s:8:\"addField\";i:1;s:9:\"updatelog\";i:2;s:8:\"ul_value\";i:3;s:18:\"patch-ul_value.sql\";}i:118;a:4:{i:0;s:8:\"addField\";i:1;s:9:\"interwiki\";i:2;s:6:\"iw_api\";i:3;s:27:\"patch-iw_api_and_wikiid.sql\";}i:119;a:4:{i:0;s:9:\"dropIndex\";i:1;s:7:\"iwlinks\";i:2;s:10:\"iwl_prefix\";i:3;s:25:\"patch-kill-iwl_prefix.sql\";}i:120;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"categorylinks\";i:2;s:12:\"cl_collation\";i:3;s:40:\"patch-categorylinks-better-collation.sql\";}i:121;a:1:{i:0;s:16:\"doClFieldsUpdate\";}i:122;a:3:{i:0;s:8:\"addTable\";i:1;s:11:\"module_deps\";i:2;s:21:\"patch-module_deps.sql\";}i:123;a:4:{i:0;s:9:\"dropIndex\";i:1;s:7:\"archive\";i:2;s:13:\"ar_page_revid\";i:3;s:36:\"patch-archive_kill_ar_page_revid.sql\";}i:124;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"archive\";i:2;s:8:\"ar_revid\";i:3;s:26:\"patch-archive_ar_revid.sql\";}i:125;a:1:{i:0;s:23:\"doLangLinksLengthUpdate\";}i:126;a:1:{i:0;s:29:\"doUserNewTalkTimestampNotNull\";}i:127;a:4:{i:0;s:8:\"addIndex\";i:1;s:4:\"user\";i:2;s:10:\"user_email\";i:3;s:26:\"patch-user_email_index.sql\";}i:128;a:4:{i:0;s:11:\"modifyField\";i:1;s:15:\"user_properties\";i:2;s:11:\"up_property\";i:3;s:21:\"patch-up_property.sql\";}i:129;a:3:{i:0;s:8:\"addTable\";i:1;s:11:\"uploadstash\";i:2;s:21:\"patch-uploadstash.sql\";}i:130;a:3:{i:0;s:8:\"addTable\";i:1;s:18:\"user_former_groups\";i:2;s:28:\"patch-user_former_groups.sql\";}i:131;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"logging\";i:2;s:11:\"type_action\";i:3;s:35:\"patch-logging-type-action-index.sql\";}i:132;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"revision\";i:2;s:8:\"rev_sha1\";i:3;s:18:\"patch-rev_sha1.sql\";}i:133;a:1:{i:0;s:20:\"doMigrateUserOptions\";}i:134;a:4:{i:0;s:9:\"dropField\";i:1;s:4:\"user\";i:2;s:12:\"user_options\";i:3;s:27:\"patch-drop-user_options.sql\";}i:135;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:7:\"ar_sha1\";i:3;s:17:\"patch-ar_sha1.sql\";}i:136;a:4:{i:0;s:8:\"addIndex\";i:1;s:4:\"page\";i:2;s:27:\"page_redirect_namespace_len\";i:3;s:37:\"patch-page_redirect_namespace_len.sql\";}i:137;a:4:{i:0;s:8:\"addField\";i:1;s:11:\"uploadstash\";i:2;s:12:\"us_chunk_inx\";i:3;s:27:\"patch-uploadstash_chunk.sql\";}i:138;a:4:{i:0;s:8:\"addfield\";i:1;s:3:\"job\";i:2;s:13:\"job_timestamp\";i:3;s:28:\"patch-jobs-add-timestamp.sql\";}i:139;a:4:{i:0;s:8:\"addIndex\";i:1;s:8:\"revision\";i:2;s:19:\"page_user_timestamp\";i:3;s:34:\"patch-revision-user-page-index.sql\";}i:140;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"ipblocks\";i:2;s:19:\"ipb_parent_block_id\";i:3;s:29:\"patch-ipb-parent-block-id.sql\";}i:141;a:4:{i:0;s:8:\"addIndex\";i:1;s:8:\"ipblocks\";i:2;s:19:\"ipb_parent_block_id\";i:3;s:35:\"patch-ipb-parent-block-id-index.sql\";}i:142;a:4:{i:0;s:9:\"dropField\";i:1;s:8:\"category\";i:2;s:10:\"cat_hidden\";i:3;s:20:\"patch-cat_hidden.sql\";}i:143;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"revision\";i:2;s:18:\"rev_content_format\";i:3;s:37:\"patch-revision-rev_content_format.sql\";}i:144;a:4:{i:0;s:8:\"addField\";i:1;s:8:\"revision\";i:2;s:17:\"rev_content_model\";i:3;s:36:\"patch-revision-rev_content_model.sql\";}i:145;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:17:\"ar_content_format\";i:3;s:35:\"patch-archive-ar_content_format.sql\";}i:146;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:16:\"ar_content_model\";i:3;s:34:\"patch-archive-ar_content_model.sql\";}i:147;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"page\";i:2;s:18:\"page_content_model\";i:3;s:33:\"patch-page-page_content_model.sql\";}i:148;a:1:{i:0;s:25:\"enableContentHandlerUseDB\";}i:149;a:4:{i:0;s:9:\"dropField\";i:1;s:10:\"site_stats\";i:2;s:9:\"ss_admins\";i:3;s:24:\"patch-drop-ss_admins.sql\";}i:150;a:4:{i:0;s:9:\"dropField\";i:1;s:13:\"recentchanges\";i:2;s:17:\"rc_moved_to_title\";i:3;s:18:\"patch-rc_moved.sql\";}i:151;a:3:{i:0;s:8:\"addTable\";i:1;s:5:\"sites\";i:2;s:15:\"patch-sites.sql\";}i:152;a:4:{i:0;s:8:\"addField\";i:1;s:11:\"filearchive\";i:2;s:7:\"fa_sha1\";i:3;s:17:\"patch-fa_sha1.sql\";}i:153;a:4:{i:0;s:8:\"addField\";i:1;s:3:\"job\";i:2;s:9:\"job_token\";i:3;s:19:\"patch-job_token.sql\";}i:154;a:4:{i:0;s:8:\"addField\";i:1;s:3:\"job\";i:2;s:12:\"job_attempts\";i:3;s:22:\"patch-job_attempts.sql\";}i:155;a:1:{i:0;s:17:\"doEnableProfiling\";}i:156;a:4:{i:0;s:8:\"addField\";i:1;s:11:\"uploadstash\";i:2;s:8:\"us_props\";i:3;s:30:\"patch-uploadstash-us_props.sql\";}i:157;a:4:{i:0;s:11:\"modifyField\";i:1;s:11:\"user_groups\";i:2;s:8:\"ug_group\";i:3;s:38:\"patch-ug_group-length-increase-255.sql\";}i:158;a:4:{i:0;s:11:\"modifyField\";i:1;s:18:\"user_former_groups\";i:2;s:9:\"ufg_group\";i:3;s:39:\"patch-ufg_group-length-increase-255.sql\";}i:159;a:4:{i:0;s:8:\"addIndex\";i:1;s:10:\"page_props\";i:2;s:16:\"pp_propname_page\";i:3;s:40:\"patch-page_props-propname-page-index.sql\";}i:160;a:4:{i:0;s:8:\"addIndex\";i:1;s:5:\"image\";i:2;s:14:\"img_media_mime\";i:3;s:30:\"patch-img_media_mime-index.sql\";}i:161;a:1:{i:0;s:23:\"doIwlinksIndexNonUnique\";}i:162;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"iwlinks\";i:2;s:21:\"iwl_prefix_from_title\";i:3;s:34:\"patch-iwlinks-from-title-index.sql\";}i:163;a:4:{i:0;s:8:\"addField\";i:1;s:7:\"archive\";i:2;s:5:\"ar_id\";i:3;s:23:\"patch-archive-ar_id.sql\";}i:164;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"externallinks\";i:2;s:5:\"el_id\";i:3;s:29:\"patch-externallinks-el_id.sql\";}i:165;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"recentchanges\";i:2;s:9:\"rc_source\";i:3;s:19:\"patch-rc_source.sql\";}i:166;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"logging\";i:2;s:23:\"log_user_text_type_time\";i:3;s:43:\"patch-logging_user_text_type_time_index.sql\";}i:167;a:4:{i:0;s:8:\"addIndex\";i:1;s:7:\"logging\";i:2;s:18:\"log_user_text_time\";i:3;s:38:\"patch-logging_user_text_time_index.sql\";}i:168;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"page\";i:2;s:18:\"page_links_updated\";i:3;s:28:\"patch-page_links_updated.sql\";}i:169;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"user\";i:2;s:21:\"user_password_expires\";i:3;s:30:\"patch-user_password_expire.sql\";}i:170;a:4:{i:0;s:8:\"addField\";i:1;s:10:\"page_props\";i:2;s:10:\"pp_sortkey\";i:3;s:20:\"patch-pp_sortkey.sql\";}i:171;a:4:{i:0;s:9:\"dropField\";i:1;s:13:\"recentchanges\";i:2;s:11:\"rc_cur_time\";i:3;s:26:\"patch-drop-rc_cur_time.sql\";}i:172;a:4:{i:0;s:8:\"addIndex\";i:1;s:9:\"watchlist\";i:2;s:29:\"wl_user_notificationtimestamp\";i:3;s:52:\"patch-watchlist-user-notificationtimestamp-index.sql\";}i:173;a:4:{i:0;s:8:\"addField\";i:1;s:4:\"page\";i:2;s:9:\"page_lang\";i:3;s:19:\"patch-page_lang.sql\";}i:174;a:4:{i:0;s:8:\"addField\";i:1;s:9:\"pagelinks\";i:2;s:17:\"pl_from_namespace\";i:3;s:27:\"patch-pl_from_namespace.sql\";}i:175;a:4:{i:0;s:8:\"addField\";i:1;s:13:\"templatelinks\";i:2;s:17:\"tl_from_namespace\";i:3;s:27:\"patch-tl_from_namespace.sql\";}i:176;a:4:{i:0;s:8:\"addField\";i:1;s:10:\"imagelinks\";i:2;s:17:\"il_from_namespace\";i:3;s:27:\"patch-il_from_namespace.sql\";}i:177;a:4:{i:0;s:11:\"modifyField\";i:1;s:5:\"image\";i:2;s:14:\"img_major_mime\";i:3;s:33:\"patch-img_major_mime-chemical.sql\";}i:178;a:4:{i:0;s:11:\"modifyField\";i:1;s:8:\"oldimage\";i:2;s:13:\"oi_major_mime\";i:3;s:32:\"patch-oi_major_mime-chemical.sql\";}i:179;a:4:{i:0;s:11:\"modifyField\";i:1;s:11:\"filearchive\";i:2;s:13:\"fa_major_mime\";i:3;s:32:\"patch-fa_major_mime-chemical.sql\";}i:180;a:1:{i:0;s:27:\"doUserNewTalkUseridUnsigned\";}i:181;a:4:{i:0;s:11:\"modifyField\";i:1;s:13:\"recentchanges\";i:2;s:10:\"rc_comment\";i:3;s:28:\"patch-editsummary-length.sql\";}i:182;a:2:{i:0;s:9:\"dropTable\";i:1;s:10:\"hitcounter\";}i:183;a:4:{i:0;s:9:\"dropField\";i:1;s:10:\"site_stats\";i:2;s:14:\"ss_total_views\";i:3;s:29:\"patch-drop-ss_total_views.sql\";}i:184;a:4:{i:0;s:9:\"dropField\";i:1;s:4:\"page\";i:2;s:12:\"page_counter\";i:3;s:27:\"patch-drop-page_counter.sql\";}i:185;a:2:{i:0;s:9:\"dropTable\";i:1;s:18:\"msg_resource_links\";}i:186;a:2:{i:0;s:9:\"dropTable\";i:1;s:12:\"msg_resource\";}i:187;a:3:{i:0;s:8:\"addTable\";i:1;s:13:\"bot_passwords\";i:2;s:23:\"patch-bot_passwords.sql\";}i:188;a:4:{i:0;s:8:\"addField\";i:1;s:9:\"watchlist\";i:2;s:5:\"wl_id\";i:3;s:25:\"patch-watchlist-wl_id.sql\";}i:189;a:4:{i:0;s:9:\"dropIndex\";i:1;s:13:\"categorylinks\";i:2;s:12:\"cl_collation\";i:3;s:33:\"patch-kill-cl_collation_index.sql\";}i:190;a:4:{i:0;s:8:\"addIndex\";i:1;s:13:\"categorylinks\";i:2;s:16:\"cl_collation_ext\";i:3;s:36:\"patch-add-cl_collation_ext_index.sql\";}i:191;a:1:{i:0;s:17:\"doCollationUpdate\";}}')
15:28:14 Function: DatabaseUpdater::setAppliedUpdates
15:28:14 Error: 1062 Duplicate entry 'updatelist-1.27.4-15295948940' for key 'PRIMARY' (localhost:/tmp/quibble-mysql-89mojr6o/socket)
15:28:14 
15:28:14 Backtrace:
15:28:14 #0 /workspace/src/includes/db/Database.php(901): DatabaseBase->reportQueryError('Duplicate entry...', 1062, 'INSERT  INTO `u...', 'DatabaseUpdater...', false)
15:28:14 #1 /workspace/src/includes/db/Database.php(1467): DatabaseBase->query('INSERT  INTO `u...', 'DatabaseUpdater...')
15:28:14 #2 /workspace/src/includes/installer/DatabaseUpdater.php(481): DatabaseBase->insert('`updatelog`', Array, 'DatabaseUpdater...')
15:28:14 #3 /workspace/src/includes/installer/DatabaseUpdater.php(427): DatabaseUpdater->setAppliedUpdates('1.27.4', Array)
15:28:14 #4 /workspace/src/maintenance/update.php(199): DatabaseUpdater->doUpdates(Array)
15:28:14 #5 /workspace/src/maintenance/doMaintenance.php(103): UpdateMediaWiki->execute()
15:28:14 #6 /workspace/src/maintenance/update.php(244): require_once('/workspace/src/...')
15:28:14 #7 {main}
15:28:14 Traceback (most recent call last):
15:28:14   File "/usr/local/bin/quibble", line 11, in <module>
15:28:14     load_entry_point('quibble==0.0.0', 'console_scripts', 'quibble')()
15:28:14   File "/usr/local/lib/python3.5/dist-packages/quibble/cmd.py", line 462, in main
15:28:14     cmd.execute()
15:28:14   File "/usr/local/lib/python3.5/dist-packages/quibble/cmd.py", line 371, in execute
15:28:14     self.mw_install()
15:28:14   File "/usr/local/lib/python3.5/dist-packages/quibble/cmd.py", line 263, in mw_install
15:28:14     mwdir=self.mw_install_path
15:28:14   File "/usr/local/lib/python3.5/dist-packages/quibble/mediawiki/maintenance.py", line 22, in update
15:28:14     'Update failed with exit code: %s' % p.returncode)
15:28:14 Exception: Update failed with exit code: 1
15:28:14 INFO:backend.MySQL:Terminating MySQL
15:28:16 Build step 'Execute shell' marked build as failure
15:28:16 Archiving artifacts
15:28:16 [PostBuildScript] - Execution post build scripts.
15:28:16 [PostBuildScript] Build is not success : do not execute script
15:28:16 [PostBuildScript] - Execution post build scripts.
15:28:16 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins3026842102589495103.sh
15:28:16 + echo 'Clearing /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/cache'
15:28:16 Clearing /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/cache
15:28:16 ++ pwd
15:28:16 ++ egrep -v '^(HOME|SHELL|PATH|LOGNAME|MAIL|HHVM_REPO_CENTRAL_PATH)='
15:28:16 + exec docker run --rm --env-file /dev/fd/63 --volume /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/cache:/cache docker-registry.wikimedia.org/releng/castor:0.1.3 clear
15:28:16 ++ /usr/bin/env
15:28:17 Finished: FAILURE