+ set -e + set -o pipefail ++ dirname ./run.sh + cd . + echo 8478 + echo '1.62.2 ce7ad22' 1.62.2 ce7ad22 + date Thu Dec 29 13:11:19 UTC 2016 + uptime 13:11:19 up 40 days, 19:25, 0 users, load average: 7.02, 7.87, 5.27 + head=git@github.com:yegor256/est.git + head_branch=master + tag=0.3.3 + vars=('--env=head=git@github.com:yegor256/est.git' '--env=head_branch=master' '--env=tag=0.3.3') + image=yegor256/rultor + directory= + scripts=('sudo gem install pdd' ';' 'sudo gem install est' ';' 'pdd --verbose --file=/dev/null' ';' 'sudo bundle install' ';' 'rake' ';' 'rm -rf *.gem' ';' 'sed -i "s/1\.0\.snapshot/${tag}/g" lib/est/version.rb' ';' 'git add lib/est/version.rb' ';' 'git commit -m "version set to ${tag}"' ';' 'gem build est.gemspec' ';' 'chmod 0600 ../rubygems.yml' ';' 'gem push *.gem --config-file ../rubygems.yml' ';' 's3cmd --no-progress put assets/est.xsd --acl-public --config=../s3cfg s3://est-xsd.teamed.io/${tag}.xsd' ';' 's3cmd --no-progress put assets/est.xsl --acl-public --config=../s3cfg s3://est-xsl.teamed.io/${tag}.xsl' ';' 'est --dir=./est --format=xml --file=est-estimate.xml' ';' 's3cmd --no-progress put est-estimate.xml --config=../s3cfg s3://est.teamed.io/est.xml' ';') + squash=false + ff=default + rebase=false + container=yegor256_est_17 + as_root=false + mkdir -p /home/rultor/.ssh + echo -e 'Host github.com\n\tStrictHostKeyChecking no\n' + chmod 600 /home/rultor/.ssh/config + git clone git@github.com:yegor256/est.git repo Cloning into 'repo'... + cd repo + git config user.email me@rultor.com + git config user.name rultor + '[' -z 'sudo gem install pdd' ']' + cd .. + cat + '[' false = true ']' + cat + chmod a+x entry.sh + cat + echo 'sudo gem install pdd' ';' 'sudo gem install est' ';' 'pdd --verbose --file=/dev/null' ';' 'sudo bundle install' ';' rake ';' 'rm -rf *.gem' ';' 'sed -i "s/1\.0\.snapshot/${tag}/g" lib/est/version.rb' ';' 'git add lib/est/version.rb' ';' 'git commit -m "version set to ${tag}"' ';' 'gem build est.gemspec' ';' 'chmod 0600 ../rubygems.yml' ';' 'gem push *.gem --config-file ../rubygems.yml' ';' 's3cmd --no-progress put assets/est.xsd --acl-public --config=../s3cfg s3://est-xsd.teamed.io/${tag}.xsd' ';' 's3cmd --no-progress put assets/est.xsl --acl-public --config=../s3cfg s3://est-xsl.teamed.io/${tag}.xsl' ';' 'est --dir=./est --format=xml --file=est-estimate.xml' ';' 's3cmd --no-progress put est-estimate.xml --config=../s3cfg s3://est.teamed.io/est.xml' ';' + rm -rf .gpg + '[' -z 0.3.3 ']' + [[ 0.3.3 =~ ^[a-zA-Z0-9\\.\\-]+$ ]] + echo 'tag name is valid: "0.3.3"' tag name is valid: "0.3.3" + cd repo ++ git tag -l 0.3.3 + '[' ']' + export BRANCH_NAME=__rultor + BRANCH_NAME=__rultor ++ git show-branch __rultor ++ wc -l + '[' 0 -gt 0 ']' + git checkout -b __rultor Switched to a new branch '__rultor' + docker_when_possible + true ++ uptime ++ sed 's/ /\n/g' ++ tail -n 1 + load=5.27 ++ echo 5.27 '>' 30 ++ bc + '[' 0 -eq 1 ']' + echo 'load average is 5.27, low enough to run a new Docker container' load average is 5.27, low enough to run a new Docker container + break + cd .. + '[' -n '' ']' + use_image=yegor256/rultor + docker pull yegor256/rultor Using default tag: latest Trying to pull repository docker.io/yegor256/rultor ... latest: Pulling from yegor256/rultor Digest: sha256:ad3c8a7c0673df4f748c3bfaaa721b4d2d092a83cc8045577f33749f79e80e1e Status: Image is up to date for docker.io/yegor256/rultor:latest + grep --quiet '\syegor256_est_17\s*$' + docker ps --filter=status=exited + ls -al . total 40 drwx------ 3 rultor rultor 115 Dec 29 13:11 . drwxrwxrwt. 9 root root 4096 Dec 29 13:11 .. -rwxrwxr-x 1 rultor rultor 326 Dec 29 13:11 entry.sh -rw-rw-r-- 1 rultor rultor 5 Dec 29 13:11 pid drwxrwxr-x 9 rultor rultor 4096 Dec 29 13:11 repo -rw-rw-r-- 1 rultor rultor 56 Dec 29 13:11 rubygems.yml -rwxrwxr-x 1 rultor rultor 4789 Dec 29 13:11 run.sh -rw-rw-r-- 1 rultor rultor 98 Dec 29 13:11 s3cfg -rw-rw-r-- 1 rultor rultor 781 Dec 29 13:11 script.sh -rw-rw-r-- 1 rultor rultor 3494 Dec 29 13:11 stdout ++ pwd ++ pwd + docker run -t --rm -v /tmp/rultor-slt0:/main --env=head=git@github.com:yegor256/est.git --env=head_branch=master --env=tag=0.3.3 --hostname=docker --privileged --memory=6g --memory-swap=16g --oom-kill-disable --cidfile=/tmp/rultor-slt0/cid -w=/main --name=yegor256_est_17 yegor256/rultor /main/entry.sh Usage of loopback devices is strongly discouraged for production use. Either use `--storage-opt dm.thinpooldev` or use `--storage-opt dm.no_warn_on_loop_devices=true` to suppress this warning. + set -e + set -o pipefail + shopt -s dotglob + useradd -m -G sudo r + echo '%sudo ALL=(ALL) NOPASSWD:ALL' + cp -R /root/.bashrc /root/.composer /root/.gem /root/.java /root/.m2 /root/.npm /root/.profile /root/texmf /root/.texmf-var /root/tmp /home/r + cp -R ./cid ./end.sh ./entry.sh ./pid ./repo ./rubygems.yml ./run.sh ./s3cfg ./script.sh ./stdout /home/r + rm -rf repo + chown -R r:r /home/r + chmod a+x /home/r/script.sh + su -m r -c /home/r/script.sh + set -e + set -o pipefail + export HOME=/home/r + HOME=/home/r + cd /home/r/repo + sudo gem install pdd Fetching: slop-3.6.0.gem (100%) Successfully installed slop-3.6.0 Fetching: ptools-1.3.3.gem (100%) Successfully installed ptools-1.3.3 Fetching: pdd-0.17.1.gem (100%) Successfully installed pdd-0.17.1 Parsing documentation for slop-3.6.0 Installing ri documentation for slop-3.6.0 Parsing documentation for ptools-1.3.3 Installing ri documentation for ptools-1.3.3 Parsing documentation for pdd-0.17.1 Installing ri documentation for pdd-0.17.1 Done installing documentation for slop, ptools, pdd after 0 seconds 3 gems installed + sudo gem install est Fetching: ruby-filemagic-0.7.1.gem (100%) Building native extensions. This could take a while... ruby-filemagic-0.7.1 [2015-10-27]: * List default lib and header directories (pull request #18 by Adam Wróbel). Successfully installed ruby-filemagic-0.7.1 Fetching: mini_portile-0.6.2.gem (100%) Successfully installed mini_portile-0.6.2 Fetching: nokogiri-1.6.6.4.gem (100%) Building native extensions. This could take a while... Successfully installed nokogiri-1.6.6.4 Fetching: est-0.3.2.gem (100%) Successfully installed est-0.3.2 Parsing documentation for ruby-filemagic-0.7.1 Installing ri documentation for ruby-filemagic-0.7.1 Parsing documentation for mini_portile-0.6.2 Installing ri documentation for mini_portile-0.6.2 Parsing documentation for nokogiri-1.6.6.4 Installing ri documentation for nokogiri-1.6.6.4 Parsing documentation for est-0.3.2 Installing ri documentation for est-0.3.2 Done installing documentation for ruby-filemagic, mini_portile, nokogiri, est after 7 seconds 4 gems installed + pdd --verbose --file=/dev/null INFO: "my version is 0.17.1" INFO: "Ruby version is 2.2.4 at x86_64-linux-gnu" INFO: "reading ." INFO: "excluding target/**/*" INFO: "excluding src/main/resources/images/**/*" INFO: "37 file(s) found" INFO: "reading Gemfile..." INFO: "reading LICENSE.txt..." INFO: "reading README.md..." INFO: "reading Rakefile..." INFO: "reading TEAM.md..." INFO: "reading assets/est-text.xsl..." INFO: "reading assets/est.xsd..." INFO: "reading assets/est.xsl..." INFO: "reading bin/est..." INFO: "reading cucumber.yml..." INFO: "reading est.gemspec..." INFO: "reading est/first.est..." INFO: "reading features/cli.feature..." INFO: "reading features/empty_dir.feature..." INFO: "reading features/gem_package.feature..." INFO: "reading features/step_definitions/steps.rb..." INFO: "reading features/support/env.rb..." INFO: "reading lib/est.rb..." INFO: "reading lib/est/estimate.rb..." INFO: "reading lib/est/estimates.rb..." INFO: "reading lib/est/methods/champions.rb..." INFO: "reading lib/est/version.rb..." INFO: "reading test/test__helper.rb..." INFO: "reading test/test_champions.rb..." INFO: "reading test/test_est.rb..." INFO: "reading test/test_estimate.rb..." INFO: "reading test/test_estimates.rb..." + sudo bundle install 33mDon't run Bundler as root. Bundler can ask for sudo if it is needed, and installing your bundle as root will break this application for all non-root users on this machine.0m Fetching gem metadata from https://rubygems.org/.......... Fetching version metadata from https://rubygems.org/... Fetching dependency metadata from https://rubygems.org/.. Resolving dependencies................... Using rake 10.4.2 32mInstalling concurrent-ruby 1.0.40m 32mInstalling i18n 0.7.00m 32mInstalling minitest 5.5.00m 32mInstalling thread_safe 0.3.50m 32mInstalling builder 3.2.20m 32mInstalling erubis 2.7.00m Using mini_portile 0.6.2 32mInstalling rack 2.0.10m 32mInstalling ast 2.3.00m 32mInstalling multi_json 1.12.10m 32mInstalling mime-types-data 3.2016.05210m 32mInstalling docile 1.1.50m Using json 1.8.3 32mInstalling simplecov-html 0.10.00m 32mInstalling tins 0.13.20m 32mInstalling thor 0.18.10m 32mInstalling diff-lcs 1.2.50m 32mInstalling multi_test 0.1.20m Using slop 3.6.0 32mInstalling method_source 0.8.20m 32mInstalling powerpack 0.0.90m 32mInstalling rainbow 2.2.1 with native extensions0m Using rdoc 4.2.0 32mInstalling rspec-support 3.1.20m 32mInstalling ruby-progressbar 1.8.10m 32mInstalling rubocop-rspec 1.2.10m Using bundler 1.11.2 32mInstalling tzinfo 1.2.20m Using nokogiri 1.6.6.4 32mInstalling rack-test 0.6.30m 32mInstalling parser 2.3.3.10m 32mInstalling gherkin 2.12.2 with native extensions0m 32mInstalling mime-types 3.10m 32mInstalling simplecov 0.12.00m 32mInstalling term-ansicolor 1.2.20m 32mInstalling rspec-core 3.1.70m 32mInstalling rspec-expectations 3.1.20m 32mInstalling rspec-mocks 3.1.30m 32mInstalling activesupport 5.0.10m 32mInstalling loofah 2.0.30m Using est 1.0.snapshot from source at `.` 32mInstalling rubocop 0.24.10m 32mInstalling cucumber-core 1.2.00m 32mInstalling rest-client 1.6.70m 32mInstalling rails-dom-testing 2.0.20m 32mInstalling rails-html-sanitizer 1.0.30m 32mInstalling cucumber 2.0.10m 32mInstalling coveralls 0.7.20m 32mInstalling actionview 5.0.10m 32mInstalling actionpack 5.0.10m 32mInstalling railties 5.0.10m 32mInstalling rspec-rails 3.1.00m 32mBundle complete! 8 Gemfile dependencies, 53 gems now installed.0m 32mUse `bundle show [gemname]` to see where a bundled gem is installed.0m + rake [DEPRECATION] `last_comment` is deprecated. Please use `last_description` instead. /var/lib/gems/2.2.0/gems/rest-client-1.6.7/lib/restclient/exceptions.rb:157: warning: assigned but unused variable - message /var/lib/gems/2.2.0/gems/rest-client-1.6.7/lib/restclient/exceptions.rb:167: warning: assigned but unused variable - message /var/lib/gems/2.2.0/gems/rest-client-1.6.7/lib/restclient/response.rb:11: warning: method redefined; discarding old body /var/lib/gems/2.2.0/gems/rest-client-1.6.7/lib/restclient/payload.rb:47: warning: mismatched indentations at 'end' with 'case' at 40 /home/r/repo/.simplecov:26:in `<top (required)>': [DEPRECATION] ::[] is deprecated. Use ::new instead. /home/r/repo/test/test_est.rb:93: warning: method redefined; discarding old test_empty_dir /home/r/repo/test/test_est.rb:78: warning: previous definition of test_empty_dir was here Run options: --seed 58745 # Running: /home/r/repo/lib/est.rb:45: warning: instance variable @logger not initialized .INFO: "my version is 1.0.snapshot" INFO: "reading /tmp/test20161229-20387-1x4h09w" /home/r/repo/lib/est/estimates.rb:58: warning: instance variable @iterate not initialized INFO: "/tmp/test20161229-20387-1x4h09w/sample.est found" INFO: "7: (10 + 40 + 18 * 4) / 6 = 20" INFO: "4: (8 + 30 + 16 * 4) / 6 = 17" INFO: "37 * 0.54 * (9 / 2) = 79.92" INFO: "2014-07-12/Yegor Bugayenko: 79" .INFO: "my version is 1.0.snapshot" INFO: "reading /tmp/test20161229-20387-cg9weq/absent" /home/r/repo/lib/est/estimates.rb:58: warning: instance variable @iterate not initialized INFO: "/tmp/test20161229-20387-cg9weq/absent is absent or is not a directory" ./home/r/repo/lib/est/estimates.rb:58: warning: instance variable @iterate not initialized INFO: "/tmp/test20161229-20387-1j2t7gh/first.est found" INFO: "7: (10 + 40 + 18 * 4) / 6 = 20" INFO: "4: (8 + 30 + 16 * 4) / 6 = 17" INFO: "37 * 0.54 * (9 / 2) = 79.92" INFO: "2014-08-12/Yegor Bugayenko: 79" .INFO: "7: (10 + 40 + 18 * 4) / 6 = 20" INFO: "4: (8 + 30 + 16 * 4) / 6 = 17" INFO: "37 * 0.54 * (9 / 2) = 79.92" . Finished in 0.021984s, 227.4402 runs/s, 227.4402 assertions/s. 5 runs, 5 assertions, 0 failures, 0 errors, 0 skips Coverage report generated for Unit Tests to /home/r/repo/coverage. 130 / 130 LOC (100.0%) covered. 33m[Coveralls] Outside the Travis environment, not sending data.0m /usr/bin/ruby2.2 -S bundle exec cucumber --profile travis /home/r/repo/.simplecov:26:in `<top (required)>': [DEPRECATION] ::[] is deprecated. Use ::new instead. Using the travis profile... 32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m/var/lib/gems/2.2.0/gems/slop-3.6.0/lib/slop.rb:252:in `parse!': Unknown options --some-unknown-option (Slop::InvalidOptionError) from /var/lib/gems/2.2.0/gems/slop-3.6.0/lib/slop.rb:65:in `parse!' from /var/lib/gems/2.2.0/gems/slop-3.6.0/lib/slop.rb:54:in `parse' from /home/r/repo/features/step_definitions/../../bin/est:32:in `<main>' 32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m 8 scenarios (32m8 passed0m) 29 steps (32m29 passed0m) 0m7.671s Coverage report generated for Cucumber Features, Unit Tests to /home/r/repo/coverage. 130 / 130 LOC (100.0%) covered. 33m[Coveralls] Outside the Travis environment, not sending data.0m warning: parser/current is loading parser/ruby22, which recognizes warning: 2.2.6-compliant syntax, but you are running 2.2.4. warning: please see https://github.com/whitequark/parser#compatibility-with-ruby-mri. Running RuboCop... Inspecting 15 files 32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m32m.0m 15 files inspected, 32mno offenses detected0m grep -q -r '2014-2016' --include '*.rb' --include '*.txt' --include 'Rakefile' . + rm -rf '*.gem' + sed -i 's/1\.0\.snapshot/0.3.3/g' lib/est/version.rb + git add lib/est/version.rb + git commit -m 'version set to 0.3.3' [__rultor e110627] version set to 0.3.3 1 file changed, 1 insertion(+), 1 deletion(-) + gem build est.gemspec Successfully built RubyGem Name: est Version: 0.3.3 File: est-0.3.3.gem + chmod 0600 ../rubygems.yml + gem push est-0.3.3.gem --config-file ../rubygems.yml Pushing gem to https://rubygems.org... Successfully registered gem: est (0.3.3) + s3cmd --no-progress put assets/est.xsd --acl-public --config=../s3cfg s3://est-xsd.teamed.io/0.3.3.xsd WARNING: Module python-magic is not available. Guessing MIME types based on file extensions. File 'assets/est.xsd' stored as 's3://est-xsd.teamed.io/0.3.3.xsd' (2055 bytes in 0.1 seconds, 31.51 kB/s) [1 of 1] Public URL of the object is: http://est-xsd.teamed.io.s3.amazonaws.com/0.3.3.xsd + s3cmd --no-progress put assets/est.xsl --acl-public --config=../s3cfg s3://est-xsl.teamed.io/0.3.3.xsl WARNING: Module python-magic is not available. Guessing MIME types based on file extensions. File 'assets/est.xsl' stored as 's3://est-xsl.teamed.io/0.3.3.xsl' (2736 bytes in 0.4 seconds, 7.61 kB/s) [1 of 1] Public URL of the object is: http://est-xsl.teamed.io.s3.amazonaws.com/0.3.3.xsl + est --dir=./est --format=xml --file=est-estimate.xml + s3cmd --no-progress put est-estimate.xml --config=../s3cfg s3://est.teamed.io/est.xml WARNING: Module python-magic is not available. Guessing MIME types based on file extensions. File 'est-estimate.xml' stored as 's3://est.teamed.io/est.xml' (438 bytes in 0.1 seconds, 4.11 kB/s) [1 of 1] + mv /home/r/repo . ++ whoami + chown -R root repo + '[' -n '' ']' ++ whoami + sudo chown -R rultor repo + cd repo + git checkout __rultor Already on '__rultor' + git tag 0.3.3 -m '0.3.3: tagged by rultor.com' + git reset --hard HEAD is now at e110627 version set to 0.3.3 + git clean -fd Removing est-estimate.xml + git checkout master Switched to branch 'master' + git branch -D __rultor Deleted branch __rultor (was e110627). + git push --all origin ERROR: Permission to yegor256/est.git denied to rultor. fatal: Could not read from remote repository. Please make sure you have the correct access rights and the repository exists. container faac42f07ee1452a8e5eac80fa060a72a51fde5a5ca07b0f9b3b2b4011e1791b is dead Thu Dec 29 13:15:56 UTC 2016