Console Output

17:03:31 Started by user anonymous
17:03:31 Building remotely on integration-slave-docker-1006 (DebianJessieDocker m4executor) in workspace /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker
17:03:31 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins2380008466125464198.sh
17:03:31 + mkdir -m 2777 -p cache
17:03:31 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins7359830244434324420.sh
17:03:31 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
17:03:31 ++ egrep -v '^(HOME|SHELL|PATH|LOGNAME|MAIL|HHVM_REPO_CENTRAL_PATH)='
17:03:31 ++ /usr/bin/env
17:03:31 Defined: CASTOR_NAMESPACE="castor-mw-ext-and-skins/master/quibble-composer-mysql-php70-docker"
17:03:31 Syncing...
17:03:31 rsync: failed to set times on "/cache/.": Operation not permitted (1)
17:03:39 rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1668) [generator=3.1.2]
17:03:39 
17:03:39 Done
17:03:39 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins1123166673630535239.sh
17:03:39 + set -eux
17:03:39 + mkdir -m 2777 -p log
17:03:39 + 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
17:03:40 [quibble-composer-mysql-php70-docker] $ /bin/bash -eu /tmp/jenkins1859279017636308643.sh
17:03:40 ++ pwd
17:03:40 ++ /usr/bin/env
17:03:40 ++ pwd
17:03:40 ++ egrep -v '^(HOME|SHELL|PATH|LOGNAME|MAIL|HHVM_REPO_CENTRAL_PATH)='
17:03:40 + 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
17:03:41 DEBUG:quibble.cmd:Running stages: phpunit, npm-test, composer-test, qunit, selenium
17:03:41 DEBUG:quibble.cmd:ZUUL_PROJECT=mediawiki/extensions/BlueSpiceSMWConnector
17:03:41 INFO:quibble.cmd:Projects: mediawiki/core, mediawiki/skins/Vector, mediawiki/extensions/BlueSpiceSMWConnector, mediawiki/extensions/BlueSpiceFoundation, mediawiki/extensions/ExtJSBase
17:03:41 INFO:zuul.CloneMapper:Workspace path set to: /workspace/src
17:03:41 INFO:zuul.CloneMapper:Mapping projects to workspace...
17:03:41 INFO:zuul.CloneMapper:  mediawiki/core -> /workspace/src
17:03:41 INFO:zuul.CloneMapper:  mediawiki/skins/Vector -> /workspace/src/skins/Vector
17:03:41 INFO:zuul.CloneMapper:  mediawiki/extensions/BlueSpiceSMWConnector -> /workspace/src/extensions/BlueSpiceSMWConnector
17:03:41 INFO:zuul.CloneMapper:  mediawiki/extensions/BlueSpiceFoundation -> /workspace/src/extensions/BlueSpiceFoundation
17:03:41 INFO:zuul.CloneMapper:  mediawiki/extensions/ExtJSBase -> /workspace/src/extensions/ExtJSBase
17:03:41 DEBUG:zuul.CloneMapper:Checking overlap in destination directories...
17:03:41 INFO:zuul.CloneMapper:Expansion completed.
17:03:41 INFO:zuul.Cloner:Preparing 5 repositories
17:03:41 INFO:zuul.Cloner:Creating repo mediawiki/core from cache /srv/git/mediawiki/core.git
17:03:44 INFO:zuul.Cloner:Updating origin remote in repo mediawiki/core to https://gerrit.wikimedia.org/r/p/mediawiki/core
17:03:45 DEBUG:zuul.Repo:Pruning stale refs: [<git.RemoteReference "refs/remotes/origin/REL1_1">, <git.RemoteReference "refs/remotes/origin/REL1_10">, <git.RemoteReference "refs/remotes/origin/REL1_11">, <git.RemoteReference "refs/remotes/origin/REL1_12">, <git.RemoteReference "refs/remotes/origin/REL1_13">, <git.RemoteReference "refs/remotes/origin/REL1_14">, <git.RemoteReference "refs/remotes/origin/REL1_15">, <git.RemoteReference "refs/remotes/origin/REL1_16">, <git.RemoteReference "refs/remotes/origin/REL1_17">, <git.RemoteReference "refs/remotes/origin/REL1_18">, <git.RemoteReference "refs/remotes/origin/REL1_19">, <git.RemoteReference "refs/remotes/origin/REL1_2">, <git.RemoteReference "refs/remotes/origin/REL1_20">, <git.RemoteReference "refs/remotes/origin/REL1_21">, <git.RemoteReference "refs/remotes/origin/REL1_22">, <git.RemoteReference "refs/remotes/origin/REL1_24">, <git.RemoteReference "refs/remotes/origin/REL1_3">, <git.RemoteReference "refs/remotes/origin/REL1_4">, <git.RemoteReference "refs/remotes/origin/REL1_5">, <git.RemoteReference "refs/remotes/origin/REL1_6">, <git.RemoteReference "refs/remotes/origin/REL1_7">, <git.RemoteReference "refs/remotes/origin/REL1_8">, <git.RemoteReference "refs/remotes/origin/REL1_9">, <git.RemoteReference "refs/remotes/origin/fundraising/REL1_22">, <git.RemoteReference "refs/remotes/origin/fundraising/REL1_23">, <git.RemoteReference "refs/remotes/origin/fundraising/REL1_25">, <git.RemoteReference "refs/remotes/origin/fundraising/REL1_26">, <git.RemoteReference "refs/remotes/origin/wmf/1.30.0-wmf.19">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.1">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.2">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.3">, <git.RemoteReference "refs/remotes/origin/wmf/1.31.0-wmf.4">]
17:03:45 DEBUG:zuul.Repo:Resetting repository /workspace/src
17:03:45 DEBUG:zuul.Repo:Updating repository /workspace/src
17:04:02 INFO:zuul.Cloner:upstream repo has branch master
17:04:04 DEBUG:zuul.Cloner:Fetched ref master from mediawiki/core
17:04:04 DEBUG:zuul.Repo:Checking out 11a8a5b5184cea76f4ba39900c125981f05875b4
17:04:05 INFO:zuul.Cloner:Prepared mediawiki/core repo with commit 11a8a5b5184cea76f4ba39900c125981f05875b4
17:04:05 INFO:zuul.Cloner:Creating repo mediawiki/skins/Vector from upstream https://gerrit.wikimedia.org/r/p/mediawiki/skins/Vector
17:04:05 DEBUG:zuul.Repo:Cloning from https://gerrit.wikimedia.org/r/p/mediawiki/skins/Vector to /workspace/src/skins/Vector
17:04:06 DEBUG:zuul.Repo:Resetting repository /workspace/src/skins/Vector
17:04:06 DEBUG:zuul.Repo:Updating repository /workspace/src/skins/Vector
17:04:06 INFO:zuul.Cloner:upstream repo has branch master
17:04:06 DEBUG:zuul.Cloner:Fetched ref master from mediawiki/skins/Vector
17:04:06 DEBUG:zuul.Repo:Checking out 9e2bab234cd6754cd6f018783114415da4a5d966
17:04:06 INFO:zuul.Cloner:Prepared mediawiki/skins/Vector repo with commit 9e2bab234cd6754cd6f018783114415da4a5d966
17:04:06 INFO:zuul.Cloner:Creating repo mediawiki/extensions/BlueSpiceSMWConnector from upstream https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceSMWConnector
17:04:06 DEBUG:zuul.Repo:Cloning from https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceSMWConnector to /workspace/src/extensions/BlueSpiceSMWConnector
17:04:07 DEBUG:zuul.Repo:Resetting repository /workspace/src/extensions/BlueSpiceSMWConnector
17:04:07 DEBUG:zuul.Repo:Updating repository /workspace/src/extensions/BlueSpiceSMWConnector
17:04:07 INFO:zuul.Cloner:upstream repo has branch master
17:04:07 DEBUG:zuul.Cloner:Fetched ref master from mediawiki/extensions/BlueSpiceSMWConnector
17:04:07 DEBUG:zuul.Repo:Checking out 1b0786102b91505ba1bc5b0c6b9dff67dabd8fac
17:04:07 INFO:zuul.Cloner:Prepared mediawiki/extensions/BlueSpiceSMWConnector repo with commit 1b0786102b91505ba1bc5b0c6b9dff67dabd8fac
17:04:07 INFO:zuul.Cloner:Creating repo mediawiki/extensions/BlueSpiceFoundation from upstream https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceFoundation
17:04:07 DEBUG:zuul.Repo:Cloning from https://gerrit.wikimedia.org/r/p/mediawiki/extensions/BlueSpiceFoundation to /workspace/src/extensions/BlueSpiceFoundation
17:04:09 DEBUG:zuul.Repo:Resetting repository /workspace/src/extensions/BlueSpiceFoundation
17:04:09 DEBUG:zuul.Repo:Updating repository /workspace/src/extensions/BlueSpiceFoundation
17:04:09 INFO:zuul.Cloner:upstream repo has branch master
17:04:09 DEBUG:zuul.Cloner:Fetched ref master from mediawiki/extensions/BlueSpiceFoundation
17:04:09 DEBUG:zuul.Repo:Checking out bbe6feb487ca8775d56dd81f70d30746848557ee
17:04:09 INFO:zuul.Cloner:Prepared mediawiki/extensions/BlueSpiceFoundation repo with commit bbe6feb487ca8775d56dd81f70d30746848557ee
17:04:09 INFO:zuul.Cloner:Creating repo mediawiki/extensions/ExtJSBase from upstream https://gerrit.wikimedia.org/r/p/mediawiki/extensions/ExtJSBase
17:04:09 DEBUG:zuul.Repo:Cloning from https://gerrit.wikimedia.org/r/p/mediawiki/extensions/ExtJSBase to /workspace/src/extensions/ExtJSBase
17:04:10 DEBUG:zuul.Repo:Resetting repository /workspace/src/extensions/ExtJSBase
17:04:10 DEBUG:zuul.Repo:Updating repository /workspace/src/extensions/ExtJSBase
17:04:11 INFO:zuul.Cloner:upstream repo has branch master
17:04:11 DEBUG:zuul.Cloner:Fetched ref master from mediawiki/extensions/ExtJSBase
17:04:11 DEBUG:zuul.Repo:Checking out fcdad648e21f2aeb521ec287a8045e879fd5d874
17:04:11 INFO:zuul.Cloner:Prepared mediawiki/extensions/ExtJSBase repo with commit fcdad648e21f2aeb521ec287a8045e879fd5d874
17:04:11 INFO:zuul.Cloner:Prepared all repositories
17:04:11 INFO:quibble.cmd:Updating git submodules of extensions and skins
17:04:11 INFO:zuul.CloneMapper:Workspace path set to: ./
17:04:11 INFO:zuul.CloneMapper:Mapping projects to workspace...
17:04:11 INFO:zuul.CloneMapper:  mediawiki/extensions/BlueSpiceSMWConnector -> extensions/BlueSpiceSMWConnector
17:04:11 DEBUG:zuul.CloneMapper:Checking overlap in destination directories...
17:04:11 INFO:zuul.CloneMapper:Expansion completed.
17:04:11 INFO:test.run_extskin:Running "composer test" for BlueSpiceSMWConnector
17:04:11 ./composer.json is valid
17:04:11 [6.0MB/0.01s] Loading composer repositories with package information
17:04:12 [6.3MB/0.15s] Updating dependencies (including require-dev)
17:04:19 [151.2MB/7.32s] Dependency resolution completed in 0.020 seconds
17:04:19 [151.3MB/7.33s] Analyzed 2116 packages to resolve dependencies
17:04:19 [151.3MB/7.33s] Analyzed 8477 rules to resolve dependencies
17:04:19 [151.7MB/7.34s] Dependency resolution completed in 0.000 seconds
17:04:19 [151.3MB/7.34s] Package operations: 9 installs, 0 updates, 0 removals
17:04:19 [151.3MB/7.34s] Installs: composer/installers:v1.5.0, jakub-onderka/php-parallel-lint:v1.0.0, jakub-onderka/php-console-color:0.1, jakub-onderka/php-console-highlighter:v0.3.2, psr/log:1.0.2, symfony/debug:v3.4.11, symfony/polyfill-mbstring:v1.8.0, symfony/console:v3.4.11, mediawiki/minus-x:0.3.1
17:04:19 [151.3MB/7.35s]   - Installing composer/installers (v1.5.0): [151.5MB/7.35s] Downloading[151.5MB/7.43s]  (100%)[151.5MB/7.43s] 
17:04:19 [151.5MB/7.43s]  Extracting archive[151.6MB/7.51s]   - Installing jakub-onderka/php-parallel-lint (v1.0.0): [151.6MB/7.52s] Loading from cache[151.6MB/7.52s] 
17:04:19 [151.6MB/7.52s]  Extracting archive[151.6MB/7.59s]   - Installing jakub-onderka/php-console-color (0.1): [151.6MB/7.59s] Loading from cache[151.6MB/7.59s] 
17:04:19 [151.6MB/7.59s]  Extracting archive[151.6MB/7.60s]   - Installing jakub-onderka/php-console-highlighter (v0.3.2): [151.6MB/7.60s] Loading from cache[151.6MB/7.60s] 
17:04:19 [151.6MB/7.60s]  Extracting archive[151.6MB/7.61s]   - Installing psr/log (1.0.2): [151.6MB/7.62s] Loading from cache[151.6MB/7.62s] 
17:04:19 [151.6MB/7.62s]  Extracting archive[151.6MB/7.67s]   - Installing symfony/debug (v3.4.11): [151.6MB/7.67s] Loading from cache[151.6MB/7.67s] 
17:04:19 [151.6MB/7.67s]  Extracting archive[151.6MB/7.74s]   - Installing symfony/polyfill-mbstring (v1.8.0): [151.6MB/7.74s] Loading from cache[151.6MB/7.74s] 
17:04:19 [151.6MB/7.74s]  Extracting archive[151.6MB/7.75s]   - Installing symfony/console (v3.4.11): [151.6MB/7.76s] Loading from cache[151.6MB/7.76s] 
17:04:19 [151.6MB/7.76s]  Extracting archive[151.6MB/7.84s]   - Installing mediawiki/minus-x (0.3.1): [151.6MB/7.84s] Loading from cache[151.6MB/7.84s] 
17:04:20 [151.6MB/7.84s]  Extracting archive[146.8MB/8.13s] symfony/console suggests installing symfony/event-dispatcher ()
17:04:20 [146.8MB/8.13s] symfony/console suggests installing symfony/lock ()
17:04:20 [146.8MB/8.13s] symfony/console suggests installing symfony/process ()
17:04:20 [146.8MB/8.13s] symfony/console suggests installing psr/log-implementation (For using the console logger)
17:04:20 [146.8MB/8.14s] Writing lock file
17:04:20 [146.8MB/8.14s] Generating autoload files
17:04:20 [147.0MB/8.26s] Memory usage: 146.95MB (peak: 156.43MB), time: 8.26s
17:04:20 > parallel-lint . --exclude vendor --exclude node_modules --exclude extensions
17:04:20 PHP 7.0.27 | 10 parallel jobs
17:04:21 ............................                                 28/28 (100 %)
17:04:21 
17:04:21 
17:04:21 Checked 28 files in 0.6 seconds
17:04:21 No syntax error found
17:04:21 > minus-x check .
17:04:21 MinusX
17:04:21 ======
17:04:21 Processing /workspace/src/extensions/BlueSpiceSMWConnector...
17:04:21 ...................E.........................................
17:04:21 ..............E..................
17:04:21 Error: /workspace/src/extensions/BlueSpiceSMWConnector/resources/ext.BSSMWConnector.SF.VisualEditorField.js should not be executable
17:04:21 Error: /workspace/src/extensions/BlueSpiceSMWConnector/build/release/build_tarballs.sh should not be executable
17:04:21 Script minus-x check . handling the test event returned with error code 1
17:04:21 Traceback (most recent call last):
17:04:21   File "/usr/local/bin/quibble", line 11, in <module>
17:04:21     load_entry_point('quibble==0.0.0', 'console_scripts', 'quibble')()
17:04:21   File "/usr/local/lib/python3.5/dist-packages/quibble/cmd.py", line 462, in main
17:04:21     cmd.execute()
17:04:21   File "/usr/local/lib/python3.5/dist-packages/quibble/cmd.py", line 360, in execute
17:04:21     composer=run_composer, npm=run_npm)
17:04:21   File "/usr/local/lib/python3.5/dist-packages/quibble/test.py", line 77, in run_extskin
17:04:21     subprocess.check_call(cmd, cwd=directory, env=os.environ)
17:04:21   File "/usr/lib/python3.5/subprocess.py", line 271, in check_call
17:04:21     raise CalledProcessError(retcode, cmd)
17:04:21 subprocess.CalledProcessError: Command '['composer', '--ansi', 'test']' returned non-zero exit status 1
17:04:22 Build step 'Execute shell' marked build as failure
17:04:22 Archiving artifacts
17:04:22 [PostBuildScript] - Execution post build scripts.
17:04:22 [PostBuildScript] Build is not success : do not execute script
17:04:22 [PostBuildScript] - Execution post build scripts.
17:04:22 [quibble-composer-mysql-php70-docker] $ /bin/bash -xe /tmp/jenkins6625966644392204411.sh
17:04:22 + echo 'Clearing /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/cache'
17:04:22 Clearing /srv/jenkins-workspace/workspace/quibble-composer-mysql-php70-docker/cache
17:04:22 ++ pwd
17:04:22 + 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
17:04:22 ++ /usr/bin/env
17:04:22 ++ egrep -v '^(HOME|SHELL|PATH|LOGNAME|MAIL|HHVM_REPO_CENTRAL_PATH)='
17:04:23 Finished: FAILURE