rultor.com logo This build log was produced by rultor.com for yegor256/futex#7 
+ set -e
+ set -o pipefail
++ dirname ./run.sh
+ cd .
+ echo 21343
+ echo '1.68.1 24dc2a841'
1.68.1 24dc2a841
+ date
Tue Nov 13 13:44:22 CET 2018
+ uptime
 13:44:22 up 128 days, 23:28,  1 user,  load average: 6.71, 5.63, 5.37
+ ff=default
+ image=yegor256/rultor
+ rebase=false
+ head_branch=master
+ pull_title='Delete file lock'
+ author=yegor256
+ directory=
+ head=git@github.com:yegor256/futex.git
+ pull_id=7
+ fork=git@github.com:SergeyKutsko/futex.git
+ fork_branch=patch-1
+ squash=false
+ vars=('--env=head=git@github.com:yegor256/futex.git' '--env=pull_id=7' '--env=fork=git@github.com:SergeyKutsko/futex.git' '--env=fork_branch=patch-1' '--env=head_branch=master' '--env=pull_title=Delete file lock' '--env=author=yegor256' '--env=scripts=( '\''export '\''\'\'''\''head=git@github.com:yegor256/futex.git'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''pull_id=7'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''fork=git@github.com:SergeyKutsko/futex.git'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''fork_branch=patch-1'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''head_branch=master'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''pull_title=Delete file lock'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''author=yegor256'\''\'\'''\'''\'' '\'';'\'' '\''export GEM_HOME=~/.ruby'\'' '\'';'\'' '\''export GEM_PATH=$GEM_HOME:$GEM_PATH'\'' '\'';'\'' '\''bundle install'\'' '\'';'\'' '\''rake'\'' '\'';'\'' )')
+ scripts=('export '\''head=git@github.com:yegor256/futex.git'\''' ';' 'export '\''pull_id=7'\''' ';' 'export '\''fork=git@github.com:SergeyKutsko/futex.git'\''' ';' 'export '\''fork_branch=patch-1'\''' ';' 'export '\''head_branch=master'\''' ';' 'export '\''pull_title=Delete file lock'\''' ';' 'export '\''author=yegor256'\''' ';' 'export GEM_HOME=~/.ruby' ';' 'export GEM_PATH=$GEM_HOME:$GEM_PATH' ';' 'bundle install' ';' 'rake' ';')
+ container=yegor256_futex_7
+ 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 '\''pull_id=7'\''' ';' 'export '\''fork=git@github.com:SergeyKutsko/futex.git'\''' ';' 'export '\''fork_branch=patch-1'\''' ';' 'export '\''head_branch=master'\''' ';' 'export '\''pull_title=Delete file lock'\''' ';' 'export '\''author=yegor256'\''' ';' 'export GEM_HOME=~/.ruby' ';' 'export GEM_PATH=$GEM_HOME:$GEM_PATH' ';' 'bundle install' ';' rake ';'
+ sensitive=()
+ rm -rf .gpg
+ cd repo
+ git remote add fork git@github.com:SergeyKutsko/futex.git
+ git remote update
Fetching origin
Fetching fork
From github.com:SergeyKutsko/futex
 * [new branch]      master     -> fork/master
 * [new branch]      patch-1    -> fork/patch-1
+ args=
+ '[' default == default ']'
+ args=' --ff'
+ '[' default == no ']'
+ '[' default == only ']'
+ export BRANCH=__rultor
+ BRANCH=__rultor
++ wc -l
++ git show-branch __rultor
+ '[' 0 -gt 0 ']'
+ git checkout -B __rultor fork/patch-1
Switched to a new branch '__rultor'
Branch __rultor set up to track remote branch patch-1 from fork.
+ git checkout -B master origin/master
Switched to and reset branch 'master'
Branch master set up to track remote branch master from origin.
Your branch is up-to-date with 'origin/master'.
+ '[' false == true ']'
+ '[' false == true ']'
+ git merge --ff __rultor
Updating bd5a46f..7ba505a
Fast-forward
 lib/futex.rb | 3 +++
 1 file changed, 3 insertions(+)
+ docker_when_possible
+ true
++ uptime
++ sed 's/ /\n/g'
++ tail -n 1
+ load=5.38
++ echo 5.38 '>' 30
++ bc
+ '[' 0 -eq 1 ']'
+ echo 'load average is 5.38, low enough to run a new Docker container'
load average is 5.38, 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_7\s*$'
+ ls -al .
total 368
drwx--x--x  3 rultor rultor   4096 Nov 13 13:44 .
drwxrwxrwt 14 root   root   327680 Nov 13 13:44 ..
-rw-rw-r--  1 rultor rultor    444 Nov 13 13:44 end.sh
-rwxrwxr-x  1 rultor rultor    338 Nov 13 13:44 entry.sh
-rw-rw-r--  1 rultor rultor      6 Nov 13 13:44 pid
drwxrwxr-x  5 rultor rultor   4096 Nov 13 13:44 repo
-rw-rw-r--  1 rultor rultor     56 Nov 13 13:44 rubygems.yml
-rwxrwxr-x  1 rultor rultor   5559 Nov 13 13:44 run.sh
-rw-rw-r--  1 rultor rultor    461 Nov 13 13:44 script.sh
-rw-rw-r--  1 rultor rultor   4383 Nov 13 13:44 stdout
++ pwd
++ pwd
+ docker run -t --rm -v /tmp/rultor-9quJ:/main --env=head=git@github.com:yegor256/futex.git --env=pull_id=7 --env=fork=git@github.com:SergeyKutsko/futex.git --env=fork_branch=patch-1 --env=head_branch=master '--env=pull_title=Delete file lock' --env=author=yegor256 '--env=scripts=( '\''export '\''\'\'''\''head=git@github.com:yegor256/futex.git'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''pull_id=7'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''fork=git@github.com:SergeyKutsko/futex.git'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''fork_branch=patch-1'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''head_branch=master'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''pull_title=Delete file lock'\''\'\'''\'''\'' '\'';'\'' '\''export '\''\'\'''\''author=yegor256'\''\'\'''\'''\'' '\'';'\'' '\''export GEM_HOME=~/.ruby'\'' '\'';'\'' '\''export GEM_PATH=$GEM_HOME:$GEM_PATH'\'' '\'';'\'' '\''bundle install'\'' '\'';'\'' '\''rake'\'' '\'';'\'' )' --hostname=docker --privileged --memory=6g --memory-swap=16g --oom-kill-disable --cidfile=/tmp/rultor-9quJ/cid -w=/main -v /var/run/docker.sock:/var/run/docker.sock --name=yegor256_futex_7 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 pull_id=7
+ pull_id=7
+ export fork=git@github.com:SergeyKutsko/futex.git
+ fork=git@github.com:SergeyKutsko/futex.git
+ export fork_branch=patch-1
+ fork_branch=patch-1
+ export head_branch=master
+ head_branch=master
+ export 'pull_title=Delete file lock'
+ pull_title='Delete file lock'
+ 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.30m
32mInstalling concurrent-ruby 1.1.30m
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 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.00m
32mInstalling unicode-display_width 1.4.00m
32mFetching rubocop 0.58.10m
32mInstalling rubocop 0.58.10m
GemWrappers: Can not wrap missing file: rubocop
32mFetching rubocop-rspec 1.30.00m
32mInstalling rubocop-rspec 1.30.00m
32mFetching threads 0.3.00m
32mInstalling threads 0.3.00m
32mBundle complete! 7 Gemfile dependencies, 18 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 18151

# Running:

S[2018-11-13 12:44:51.997] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.10"
+"op no.20"
: nil
[2018-11-13 12:44:52.006] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.21"
+"op no.2"
: nil
[2018-11-13 12:44:52.022] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.5"
+"op no.22"
: nil
[2018-11-13 12:44:52.033] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.23"
+"op no.18"
: nil
[2018-11-13 12:44:52.047] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.17"
+"op no.24"
: nil
[2018-11-13 12:44:52.059] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.25"
+"op no.19"
: nil
[2018-11-13 12:44:52.073] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.13"
+"op no.26"
: nil
[2018-11-13 12:44:52.084] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.27"
+"op no.14"
: nil
[2018-11-13 12:44:52.098] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.28"
+"op no.15"
: nil
[2018-11-13 12:44:52.114] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.7"
+"op no.29"
: nil
[2018-11-13 12:44:52.125] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.30"
+"op no.11"
: nil
[2018-11-13 12:44:52.139] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.31"
+"op no.8"
: nil
[2018-11-13 12:44:52.151] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.32"
+"op no.6"
: nil
[2018-11-13 12:44:52.165] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.33"
+"op no.1"
: nil
[2018-11-13 12:44:52.177] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.34"
+"op no.12"
: nil
[2018-11-13 12:44:52.192] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.35"
+"op no.0"
: nil
[2018-11-13 12:44:52.203] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.36"
+"op no.16"
: nil
[2018-11-13 12:44:52.217] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.37"
+"op no.4"
: nil
[2018-11-13 12:44:52.232] ERROR -- --- expected
+++ actual
@@ -1,2 +1 @@
-# encoding: UTF-8
-"op no.38"
+"op no.9"
: nil
ELocked by "assert-thread-0" in 0ms: /tmp/d20181113-265-y79siq/a/b/c/file.txt (attempt no.0)
Unlocked by "assert-thread-0" in 0ms: /tmp/d20181113-265-y79siq/a/b/c/file.txt
Locked by "assert-thread-1" in 5ms: /tmp/d20181113-265-y79siq/a/b/c/file.txt (attempt no.1)
Unlocked by "assert-thread-1" in 0ms: /tmp/d20181113-265-y79siq/a/b/c/file.txt
.

Finished in 2.042160s, 1.4690 runs/s, 98.9149 assertions/s.

  1) Error:
FutexTest#test_syncs_access_to_file_in_slow_motion:
RuntimeError: Only 1 out of 20 threads completed successfully
    /home/r/.ruby/gems/threads-0.3.0/lib/threads.rb:70:in `assert'
    /home/r/repo/test/test_futex.rb:51:in `block in test_syncs_access_to_file_in_slow_motion'
    /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:49:in `test_syncs_access_to_file_in_slow_motion'

3 runs, 202 assertions, 0 failures, 1 errors, 1 skips

You have skipped tests. Run with --verbose for details.
rake 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 a9baa0144d673d55ba0c37ae3ff6c3f22d232e53f9af7ef2b4f46641ce5d6456 is dead
Tue Nov 13 13:46:12 CET 2018