rultor.com logo This build log was produced by rultor.com for yegor256/futex#24
+ set -e
+ set -o pipefail
++ dirname ./run.sh
+ cd .
+ echo 26970
+ echo '1.68.1 24dc2a841'
1.68.1 24dc2a841
+ date
Wed Dec 26 07:20:13 CET 2018
+ uptime
 07:20:13 up 10 days, 21:50,  0 users,  load average: 6.20, 5.93, 5.94
+ head=git@github.com:yegor256/futex.git
+ ff=default
+ image=yegor256/rultor
+ rebase=false
+ squash=false
+ head_branch=master
+ author=yegor256
+ tag=0.8.3
+ vars=('--env=head=git@github.com:yegor256/futex.git' '--env=tag=0.8.3' '--env=scripts=( '\''export '\''\'\'''\''head=git@github.com:yegor256/futex.git'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''tag=0.8.3'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''head_branch=master'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''author=yegor256'\''\'\'''\'''\'' '\'';'\'' '\''export GEM_HOME=~/.ruby'\'' '\'';'\'' '\''export GEM_PATH=$GEM_HOME:$GEM_PATH'\'' '\'';'\'' '\''bundle install'\'' '\'';'\'' '\''rake'\'' '\'';'\'' '\''rm -rf *.gem'\'' '\'';'\'' '\''sed -i "s/0\.0\.0/${tag}/g" futex.gemspec'\'' '\'';'\'' '\''git add futex.gemspec'\'' '\'';'\'' '\''git commit -m "Version set to ${tag}"'\'' '\'';'\'' '\''gem build futex.gemspec'\'' '\'';'\'' '\''chmod 0600 ../rubygems.yml'\'' '\'';'\'' '\''gem push *.gem --config-file ../rubygems.yml'\'' '\'';'\'' )' '--env=head_branch=master' '--env=author=yegor256')
+ scripts=('export '\''head=git@github.com:yegor256/futex.git'\''' ';' 'export '\''tag=0.8.3'\''' ';' 'export '\''head_branch=master'\''' ';' 'export '\''author=yegor256'\''' ';' 'export GEM_HOME=~/.ruby' ';' 'export GEM_PATH=$GEM_HOME:$GEM_PATH' ';' 'bundle install' ';' 'rake' ';' 'rm -rf *.gem' ';' 'sed -i "s/0\.0\.0/${tag}/g" futex.gemspec' ';' 'git add futex.gemspec' ';' 'git commit -m "Version set to ${tag}"' ';' 'gem build futex.gemspec' ';' 'chmod 0600 ../rubygems.yml' ';' 'gem push *.gem --config-file ../rubygems.yml' ';')
+ directory=
+ container=yegor256_futex_24
+ 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/futex.git repo
Cloning into 'repo'...
+ cd repo
+ git config user.email me@rultor.com
+ git config user.name rultor
+ '[' -z 'export '\''head=git@github.com:yegor256/futex.git'\''' ']'
+ cd ..
+ cat
+ '[' false = true ']'
+ cat
+ chmod a+x entry.sh
+ cat
+ echo 'export '\''head=git@github.com:yegor256/futex.git'\''' ';' 'export '\''tag=0.8.3'\''' ';' 'export '\''head_branch=master'\''' ';' 'export '\''author=yegor256'\''' ';' 'export GEM_HOME=~/.ruby' ';' 'export GEM_PATH=$GEM_HOME:$GEM_PATH' ';' 'bundle install' ';' rake ';' 'rm -rf *.gem' ';' 'sed -i "s/0\.0\.0/${tag}/g" futex.gemspec' ';' 'git add futex.gemspec' ';' 'git commit -m "Version set to ${tag}"' ';' 'gem build futex.gemspec' ';' 'chmod 0600 ../rubygems.yml' ';' 'gem push *.gem --config-file ../rubygems.yml' ';'
+ sensitive=()
+ rm -rf .gpg
+ '[' -z 0.8.3 ']'
+ [[ 0.8.3 =~ ^[a-zA-Z0-9\.\-]+$ ]]
+ echo 'tag name is valid: "0.8.3"'
tag name is valid: "0.8.3"
+ cd repo
++ git tag -l 0.8.3
+ '[' ']'
+ export BRANCH_NAME=__rultor
+ BRANCH_NAME=__rultor
++ wc -l
++ git show-branch __rultor
+ '[' 0 -gt 0 ']'
+ git checkout -b __rultor
Switched to a new branch '__rultor'
+ docker_when_possible
+ true
++ uptime
++ tail -n 1
++ sed 's/ /\n/g'
+ load=5.95
++ echo 5.95 '>' 30
++ bc
+ '[' 0 -eq 1 ']'
+ echo 'load average is 5.95, low enough to run a new Docker container'
load average is 5.95, low enough to run a new Docker container
+ break
+ cd ..
+ '[' -n '' ']'
+ use_image=yegor256/rultor
+ docker pull yegor256/rultor
Using default tag: latest
latest: Pulling from yegor256/rultor
Digest: sha256:7981a71e6a4a4d128e3e829e64038f8a24c3dcb45e9093e0cdbe2a6f3268604e
Status: Image is up to date for yegor256/rultor:latest
+ docker ps --filter=status=exited
+ grep --quiet '\syegor256_futex_24\s*$'
+ ls -al .
total 712
drwx--x--x  3 rultor rultor   4096 Dec 26 07:20 .
drwxrwxrwt 14 root   root   684032 Dec 26 07:20 ..
-rw-rw-r--  1 rultor rultor    444 Dec 26 07:20 end.sh
-rwxrwxr-x  1 rultor rultor    338 Dec 26 07:20 entry.sh
-rw-rw-r--  1 rultor rultor      6 Dec 26 07:20 pid
drwxrwxr-x  5 rultor rultor   4096 Dec 26 07:20 repo
-rw-rw-r--  1 rultor rultor     56 Dec 26 07:20 rubygems.yml
-rwxrwxr-x  1 rultor rultor   5710 Dec 26 07:20 run.sh
-rw-rw-r--  1 rultor rultor    562 Dec 26 07:20 script.sh
-rw-rw-r--  1 rultor rultor   3843 Dec 26 07:20 stdout
++ pwd
++ pwd
+ docker run -t --rm -v /tmp/rultor-uDuc:/main --env=head=git@github.com:yegor256/futex.git --env=tag=0.8.3 '--env=scripts=( '\''export '\''\'\'''\''head=git@github.com:yegor256/futex.git'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''tag=0.8.3'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''head_branch=master'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''author=yegor256'\''\'\'''\'''\'' '\'';'\'' '\''export GEM_HOME=~/.ruby'\'' '\'';'\'' '\''export GEM_PATH=$GEM_HOME:$GEM_PATH'\'' '\'';'\'' '\''bundle install'\'' '\'';'\'' '\''rake'\'' '\'';'\'' '\''rm -rf *.gem'\'' '\'';'\'' '\''sed -i "s/0\.0\.0/${tag}/g" futex.gemspec'\'' '\'';'\'' '\''git add futex.gemspec'\'' '\'';'\'' '\''git commit -m "Version set to ${tag}"'\'' '\'';'\'' '\''gem build futex.gemspec'\'' '\'';'\'' '\''chmod 0600 ../rubygems.yml'\'' '\'';'\'' '\''gem push *.gem --config-file ../rubygems.yml'\'' '\'';'\'' )' --env=head_branch=master --env=author=yegor256 --hostname=docker --privileged --memory=6g --memory-swap=16g --oom-kill-disable --cidfile=/tmp/rultor-uDuc/cid -w=/main -v /var/run/docker.sock:/var/run/docker.sock --name=yegor256_futex_24 yegor256/rultor /main/entry.sh
WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
+ 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/.gnupg /root/.m2 /root/.oracle_jre_usage /root/.profile /root/texmf /root/.wget-hsts /home/r
+ cp -R ./cid ./end.sh ./entry.sh ./pid ./repo ./rubygems.yml ./run.sh ./script.sh ./stdout /home/r
+ rm -rf repo
+ chown -R r:r /home/r
+ chmod a+x /home/r/script.sh
+ su --login r --command /home/r/script.sh
mesg: change /dev/pts/0 mode failed: Operation not permitted
+ set -e
+ set -o pipefail
+ shopt -s expand_aliases
+ alias 'sudo=sudo -i'
+ export HOME=/home/r
+ HOME=/home/r
+ cd /home/r/repo
+ export head=git@github.com:yegor256/futex.git
+ head=git@github.com:yegor256/futex.git
+ export tag=0.8.3
+ tag=0.8.3
+ export head_branch=master
+ head_branch=master
+ export author=yegor256
+ author=yegor256
+ export GEM_HOME=/home/r/.ruby
+ GEM_HOME=/home/r/.ruby
+ export GEM_PATH=/home/r/.ruby:/usr/local/rvm/gems/ruby-2.5.1:/usr/local/rvm/gems/ruby-2.5.1@global
+ GEM_PATH=/home/r/.ruby:/usr/local/rvm/gems/ruby-2.5.1:/usr/local/rvm/gems/ruby-2.5.1@global
+ bundle install
Fetching gem metadata from https://rubygems.org/.............
Resolving dependencies...
32mFetching rake 12.3.10m
32mInstalling rake 12.3.10m
32mFetching ast 2.4.00m
32mInstalling ast 2.4.00m
32mFetching backtrace 0.3.00m
32mInstalling backtrace 0.3.00m
Using bundler 1.16.6
32mFetching concurrent-ruby 1.1.40m
32mInstalling concurrent-ruby 1.1.40m
Using futex 0.0.0 from source at `.`
32mFetching jaro_winkler 1.5.10m
32mInstalling jaro_winkler 1.5.1 with native extensions0m
32mFetching minitest 5.11.30m
32mInstalling minitest 5.11.30m
32mFetching openssl 2.1.20m
32mInstalling openssl 2.1.2 with native extensions0m
32mFetching parallel 1.12.10m
32mInstalling parallel 1.12.10m
32mFetching parser 2.5.3.00m
32mInstalling parser 2.5.3.00m
GemWrappers: Can not wrap missing file: ruby-parse
GemWrappers: Can not wrap missing file: ruby-rewrite
32mFetching powerpack 0.1.20m
32mInstalling powerpack 0.1.20m
32mFetching rainbow 3.0.00m
32mInstalling rainbow 3.0.00m
32mFetching rdoc 4.3.00m
32mInstalling rdoc 4.3.00m
32mFetching ruby-progressbar 1.10.00m
32mInstalling ruby-progressbar 1.10.00m
32mFetching unicode-display_width 1.4.10m
32mInstalling unicode-display_width 1.4.10m
32mFetching rubocop 0.60.00m
32mInstalling rubocop 0.60.00m
GemWrappers: Can not wrap missing file: rubocop
32mFetching rubocop-rspec 1.30.10m
32mInstalling rubocop-rspec 1.30.10m
32mFetching threads 0.3.00m
32mInstalling threads 0.3.00m
32mBundle complete! 8 Gemfile dependencies, 19 gems now installed.0m
32mUse `bundle info [gemname]` to see where a bundled gem is installed.0m
+ rake
/home/r/repo/Rakefile:27: warning: already initialized constant CLEAN
/home/r/.ruby/gems/rake-12.3.1/lib/rake/clean.rb:63: warning: previous definition of CLEAN was here
Run options: --seed 8156

# Running:

.....Locked by #998-ex/assert-thread-0[/home/r/repo/test/test_futex.rb:41:in `block (2 levels) in test_syncs_access_to_file'] in 179μs, exclusive: /tmp/d20181226-998-1wqs8ic/a/b/c/file.txt (attempt no.0)
Unlocked by #998-ex/assert-thread-0[/home/r/repo/test/test_futex.rb:41:in `block (2 levels) in test_syncs_access_to_file'] in 75μs, exclusive: /tmp/d20181226-998-1wqs8ic/a/b/c/file.txt
Errno::ENOENT: No such file or directory @ rb_sysopen - /tmp/d20181226-998-1wqs8ic/a/b/c/file.txt.lock-refs
        /home/r/repo/lib/futex.rb:168:in `read'
        /home/r/repo/lib/futex.rb:168:in `block in open_synchronized'
        /home/r/repo/lib/futex.rb:189:in `block in synchronized'
        /home/r/repo/lib/futex.rb:187:in `open'
        /home/r/repo/lib/futex.rb:187:in `synchronized'
        /home/r/repo/lib/futex.rb:166:in `open_synchronized'
        /home/r/repo/lib/futex.rb:100:in `open'
        /home/r/repo/test/test_futex.rb:41:in `block (2 levels) in test_syncs_access_to_file'
        /home/r/.ruby/gems/threads-0.3.0/lib/threads.rb:57:in `block (3 levels) in assert'
        /home/r/.ruby/gems/threads-0.3.0/lib/threads.rb:53:in `loop'
        /home/r/.ruby/gems/threads-0.3.0/lib/threads.rb:53:in `block (2 levels) in assert'
        /home/r/.ruby/gems/concurrent-ruby-1.1.4/lib/concurrent/executor/ruby_thread_pool_executor.rb:348:in `run_task'
        /home/r/.ruby/gems/concurrent-ruby-1.1.4/lib/concurrent/executor/ruby_thread_pool_executor.rb:337:in `block (3 levels) in create_worker'
        /home/r/.ruby/gems/concurrent-ruby-1.1.4/lib/concurrent/executor/ruby_thread_pool_executor.rb:320:in `loop'
        /home/r/.ruby/gems/concurrent-ruby-1.1.4/lib/concurrent/executor/ruby_thread_pool_executor.rb:320:in `block (2 levels) in create_worker'
        /home/r/.ruby/gems/concurrent-ruby-1.1.4/lib/concurrent/executor/ruby_thread_pool_executor.rb:319:in `catch'
        /home/r/.ruby/gems/concurrent-ruby-1.1.4/lib/concurrent/executor/ruby_thread_pool_executor.rb:319:in `block in create_worker'
E.....

Finished in 8.077817s, 1.3618 runs/s, 149.9167 assertions/s.

  1) Error:
FutexTest#test_syncs_access_to_file:
RuntimeError: Only 1 out of 2 threads completed successfully
    /home/r/.ruby/gems/threads-0.3.0/lib/threads.rb:70:in `assert'
    /home/r/repo/test/test_futex.rb:40:in `block in test_syncs_access_to_file'
    /usr/local/rvm/rubies/ruby-2.5.1/lib/ruby/2.5.0/tmpdir.rb:89:in `mktmpdir'
    /home/r/repo/test/test_futex.rb:38:in `test_syncs_access_to_file'

11 runs, 1211 assertions, 0 failures, 1 errors, 0 skips
#<Thread:0x0000000000f68b00@/home/r/repo/test/test_futex.rb:80 aborting> terminated with exception (report_on_exception is true):
1mTracebackm (most recent call last):
        6: from /home/r/repo/test/test_futex.rb:81:in `block (2 levels) in test_raises_if_cant_lock'
        5: from /home/r/repo/lib/futex.rb:100:in `open'
        4: from /home/r/repo/lib/futex.rb:173:in `open_synchronized'
        3: from /home/r/repo/lib/futex.rb:173:in `ensure in open_synchronized'
        2: from /home/r/repo/lib/futex.rb:187:in `synchronized'
        1: from /home/r/repo/lib/futex.rb:187:in `open'
/home/r/repo/lib/futex.rb:187:in `initialize': 1mNo such file or directory @ rb_sysopen - /tmp/d20181226-998-4t1zc4/the/simple/file.txt.lock-refs (1;4mErrno::ENOENTm1m)
mrake aborted!
Command failed with status (1)
/home/r/.ruby/gems/rake-12.3.1/exe/rake:27:in `<top (required)>'
Tasks: TOP => default => test
(See full trace by running task with --trace)
container dae779142874a4473c8271177b64fcf7bbcc2b1a44beff55d07da387bfea44f6 is dead
Wed Dec 26 07:21:32 CET 2018