check flags:
Making check in externals
make[1]: Nothing to be done for `check'.
Making check in src
Making check in bin2c
make[2]: Nothing to be done for `check'.
Making check in boost
Making check in format
make[3]: Nothing to be done for `check'.
make[3]: Nothing to be done for `check-am'.
Making check in libutil
make[2]: Nothing to be done for `check'.
Making check in libstore
make[2]: Nothing to be done for `check'.
Making check in libmain
make[2]: Nothing to be done for `check'.
Making check in nix-store
make[2]: Nothing to be done for `check'.
Making check in nix-hash
make[2]: Nothing to be done for `check'.
Making check in libexpr
make[2]: Nothing to be done for `check'.
Making check in nix-instantiate
make[2]: Nothing to be done for `check'.
Making check in nix-env
make[2]: Nothing to be done for `check'.
Making check in log2xml
make[2]: Nothing to be done for `check'.
Making check in bsdiff-4.2
make[2]: Nothing to be done for `check'.
make[2]: Nothing to be done for `check-am'.
Making check in scripts
make[1]: Nothing to be done for `check'.
Making check in corepkgs
Making check in nar
make[2]: Nothing to be done for `check'.
Making check in buildenv
make[2]: Nothing to be done for `check'.
Making check in channels
make[2]: Nothing to be done for `check'.
make[2]: Nothing to be done for `check-am'.
Making check in doc
Making check in manual
make[2]: Nothing to be done for `check'.
make[2]: Nothing to be done for `check-am'.
Making check in misc
Making check in emacs
make[2]: Nothing to be done for `check'.
make[2]: Nothing to be done for `check-am'.
Making check in tests
make check-TESTS
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< simple.nix.in > simple.nix || rm simple.nix
if test -x simple.nix.in; then chmod +x simple.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< dependencies.nix.in > dependencies.nix || rm dependencies.nix
if test -x dependencies.nix.in; then chmod +x dependencies.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< locking.nix.in > locking.nix || rm locking.nix
if test -x locking.nix.in; then chmod +x locking.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< parallel.nix.in > parallel.nix || rm parallel.nix
if test -x parallel.nix.in; then chmod +x parallel.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< build-hook.nix.in > build-hook.nix || rm build-hook.nix
if test -x build-hook.nix.in; then chmod +x build-hook.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< substitutes.nix.in > substitutes.nix || rm substitutes.nix
if test -x substitutes.nix.in; then chmod +x substitutes.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< substitutes2.nix.in > substitutes2.nix || rm substitutes2.nix
if test -x substitutes2.nix.in; then chmod +x substitutes2.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< fallback.nix.in > fallback.nix || rm fallback.nix
if test -x fallback.nix.in; then chmod +x fallback.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< gc-concurrent.nix.in > gc-concurrent.nix || rm gc-concurrent.nix
if test -x gc-concurrent.nix.in; then chmod +x gc-concurrent.nix; fi
sed \
-e "s^@extra1\@^/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared^g" \
-e "s^@prefix\@^/...-nix^g" \
-e "s^@bindir\@^/...-nix/bin^g" \
-e "s^@sysconfdir\@^/...-nix/etc^g" \
-e "s^@localstatedir\@^/nix/var^g" \
-e "s^@datadir\@^/...-nix/share^g" \
-e "s^@libexecdir\@^/...-nix/libexec^g" \
-e "s^@storedir\@^/nix/store^g" \
-e "s^@system\@^powerpc-darwin^g" \
-e "s^@shell\@^//bin/sh^g" \
-e "s^@curl\@^/...-curl-7.14.0/bin/curl^g" \
-e "s^@bzip2\@^/usr/bin/bzip2^g" \
-e "s^@bunzip2\@^/usr/bin/bunzip2^g" \
-e "s^@perl\@^/...-perl/bin/perl^g" \
-e "s^@coreutils\@^//bin^g" \
-e "s^@tar\@^/usr/bin/tar^g" \
-e "s^@version\@^"0.9"^g" \
< gc-concurrent2.nix.in > gc-concurrent2.nix || rm gc-concurrent2.nix
if test -x gc-concurrent2.nix.in; then chmod +x gc-concurrent2.nix; fi
NIX_STORE_DIR=/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store NIX_DB_DIR=/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/db
/...-nix/bin
/...-nix/bin
/...-nix/bin
/...-nix/bin
upgrading Nix store to new schema (this may take a while)...
hashing paths...
processing closures...
PASS: init.sh
PASS: hash.sh
parsing lang/parse-fail-dup-attrs-1.nix (should fail)
error: duplicate attribute `x' at `(string)', line 3
parsing lang/parse-fail-dup-attrs-2.nix (should fail)
error: duplicate attribute `x' at `(string)', line 10
parsing lang/parse-fail-dup-attrs-3.nix (should fail)
error: duplicate attribute `x' at `(string)', line 10
parsing lang/parse-fail-dup-formals.nix (should fail)
error: duplicate formal function argument `x' at `(string)', line 1
parsing lang/parse-fail-undef-var.nix (should fail)
error: undefined variable `y', in `(string)'
parsing lang/parse-okay-1.nix (should succeed)
parsing lang/parse-okay-regression-20041027.nix (should succeed)
parsing lang/parse-okay-subversion.nix (should succeed)
parsing lang/parse-okay-url.nix (should succeed)
evaluating lang/eval-fail-blackhole.nix (should fail)
error: while evaluating the attribute `body' at `(string)', line 2:
while evaluating the attribute `x' at `(string)', line 3:
while evaluating the attribute `y' at `(string)', line 4:
infinite recursion encountered
evaluating lang/eval-fail-remove.nix (should fail)
error: while evaluating the attribute `body' at `(string)', line 4:
attribute `x' missing
evaluating lang/eval-okay-concat.nix (should succeed)
evaluating lang/eval-okay-let.nix (should succeed)
evaluating lang/eval-okay-map.nix (should succeed)
evaluating lang/eval-okay-remove.nix (should succeed)
evaluating lang/eval-okay-scope-1.nix (should succeed)
evaluating lang/eval-okay-scope-2.nix (should succeed)
evaluating lang/eval-okay-scope-3.nix (should succeed)
evaluating lang/eval-okay-string.nix (should succeed)
PASS: lang.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/61lygdck4nnm1dagy1731h4d6r0xxlnq-simple.drv
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7lmxg23f0lpwqcyjxqm75rnsbs3pzc12-simple'
| executing builder `//bin/sh'
+ echo PATH=/path-not-set
PATH=/path-not-set
+ mkdir foo
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/svxjg2wyqsf97kw0pxwy8aj95gaj90q8-simple.builder.sh: line 4: mkdir: command not found
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7lmxg23f0lpwqcyjxqm75rnsbs3pzc12-simple
+ echo 'Hello World!'
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7lmxg23f0lpwqcyjxqm75rnsbs3pzc12-simple'
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7lmxg23f0lpwqcyjxqm75rnsbs3pzc12-simple
PASS: simple.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1
+ echo FOO
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2
+ echo BAR
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1/foo
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2/bar
+ echo FOOBAR
+ ln -s /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2 /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies/input-2
+ ln -s /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies/self
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies
output closure contains /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies
PASS: dependencies.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/fczprbqx7mj3ifrfn2c7igfx20jw82z4-locking.drv
WORKER 1
WORKER 2
WORKER 3
WORKER 4
WORKER 5
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/priqziip0lrnnk2gz6nj5adgkrhxk1px-locking'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ sleep 3
+ touch /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/priqziip0lrnnk2gz6nj5adgkrhxk1px-locking
++ cat
+ echo -n a
+ sleep 2
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/priqziip0lrnnk2gz6nj5adgkrhxk1px-locking'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/3kda5g5vvka63izpa54grfylzggdd6sb-locking'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ sleep 3
+ touch /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/3kda5g5vvka63izpa54grfylzggdd6sb-locking
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/priqziip0lrnnk2gz6nj5adgkrhxk1px-locking
+ echo -n ad
+ sleep 2
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/3kda5g5vvka63izpa54grfylzggdd6sb-locking'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8c43ijggc5jx1qvffc9lp0s9349a7d2i-locking'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ sleep 3
+ touch /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8c43ijggc5jx1qvffc9lp0s9349a7d2i-locking
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/priqziip0lrnnk2gz6nj5adgkrhxk1px-locking
+ echo -n ab
+ sleep 2
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8c43ijggc5jx1qvffc9lp0s9349a7d2i-locking'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/0ycdhpkvc9f5dwbkk6aqii1ldvps3cqs-locking'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ sleep 3
+ touch /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/0ycdhpkvc9f5dwbkk6aqii1ldvps3cqs-locking
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/priqziip0lrnnk2gz6nj5adgkrhxk1px-locking /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8c43ijggc5jx1qvffc9lp0s9349a7d2i-locking
+ echo -n aabc
+ sleep 2
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/0ycdhpkvc9f5dwbkk6aqii1ldvps3cqs-locking'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ sleep 3
+ touch /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/0ycdhpkvc9f5dwbkk6aqii1ldvps3cqs-locking /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/3kda5g5vvka63izpa54grfylzggdd6sb-locking
+ echo -n aabcade
+ sleep 2
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking'
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking
PASS: locking.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lrmb22nfp3crv9vnrlb6z28bn8i3l2qk-parallel.drv
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wiij2nm3iicxbdagcx600kyhbhllvgn8-parallel'
| executing builder `//bin/sh'
+ echo 'DOING a'
DOING a
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+ echo 0
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+ echo 0
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 0 + 1
+ new=1
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+ test 1 -gt 0
+ echo 1
+ echo 1
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
++ cat
+ echo -n a
+ sleep 3
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 1 - 1
+ echo 0
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wiij2nm3iicxbdagcx600kyhbhllvgn8-parallel'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wv88cvsz7jflp422xi7py32w0fcysjgv-parallel'
| executing builder `//bin/sh'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/f291wk4zx7kjg8sfl1nvmagypfq7d8ci-parallel'
| executing builder `//bin/sh'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4vhmgsffcchzxbki669y35rxqyv1bll1-parallel'
| executing builder `//bin/sh'
+ echo 'DOING d'
DOING d
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ echo 'DOING b'
DOING b
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
ln: /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock: File exists
+ echo 'DOING c'
DOING c
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 0 + 1
+ new=1
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+ test 1 -gt 1
+ echo 1
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wiij2nm3iicxbdagcx600kyhbhllvgn8-parallel
+ echo -n ad
+ sleep 3
+ sleep 1
ln: /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock: File exists
+ sleep 1
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 1 + 1
+ new=2
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+ test 2 -gt 1
+ echo 2
+ echo 2
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wiij2nm3iicxbdagcx600kyhbhllvgn8-parallel
+ echo -n ab
+ sleep 3
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 2 + 1
+ new=3
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+ test 3 -gt 2
+ echo 3
+ echo 3
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wiij2nm3iicxbdagcx600kyhbhllvgn8-parallel
+ echo -n ac
+ sleep 3
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 3 - 1
+ echo 2
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wv88cvsz7jflp422xi7py32w0fcysjgv-parallel'
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 2 - 1
+ echo 1
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/f291wk4zx7kjg8sfl1nvmagypfq7d8ci-parallel'
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 1 - 1
+ echo 0
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4vhmgsffcchzxbki669y35rxqyv1bll1-parallel'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/acwl2nn7b6d3g7zmani6hq9y6ag6abw5-parallel'
| executing builder `//bin/sh'
+ echo 'DOING e'
DOING e
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 0 + 1
+ new=1
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.max
+ test 1 -gt 3
+ echo 1
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/f291wk4zx7kjg8sfl1nvmagypfq7d8ci-parallel /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4vhmgsffcchzxbki669y35rxqyv1bll1-parallel /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wv88cvsz7jflp422xi7py32w0fcysjgv-parallel
+ echo -n abacade
+ sleep 3
+ ln -s x /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
+ test -f /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
+++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.cur
++ expr 1 - 1
+ echo 0
+ rm /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/shared.lock
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/acwl2nn7b6d3g7zmani6hq9y6ag6abw5-parallel'
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/acwl2nn7b6d3g7zmani6hq9y6ag6abw5-parallel
PASS: parallel.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/731whws36hv4ylm4k44xiav3108jlv0d-build-hook.drv
HOOK for /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/6i2j4mfvbmcc973a94xd4mn9nl525hx3-build-hook-input-2.drv
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1bp7fx67g0kjlf06h5cdhsdkdlbymdlr-build-hook-input-2
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1bp7fx67g0kjlf06h5cdhsdkdlbymdlr-build-hook-input-2'
running hook to build path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cryai9cyvl626jdjm0jnp1nkqa9bjq0a-build-hook-input-1'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1bp7fx67g0kjlf06h5cdhsdkdlbymdlr-build-hook-input-2
+ echo BAR
HOOK for /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7jp8csmf9iiv048ajajpii1bq2db0z58-build-hook-input-1.drv
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cryai9cyvl626jdjm0jnp1nkqa9bjq0a-build-hook-input-1
got okay
HOOK for /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/731whws36hv4ylm4k44xiav3108jlv0d-build-hook.drv
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cryai9cyvl626jdjm0jnp1nkqa9bjq0a-build-hook-input-1/foo
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1bp7fx67g0kjlf06h5cdhsdkdlbymdlr-build-hook-input-2/bar
+ echo BARBAR
+ ln -s /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1bp7fx67g0kjlf06h5cdhsdkdlbymdlr-build-hook-input-2 /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook/input-2
+ ln -s /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook/self
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook
PASS: build-hook.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/l5z7bilix4rm8ifzdvvbhmi56x6jzjmp-substitutes.drv
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/substituter.sh'
+ echo /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes Hallo Wereld
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes Hallo Wereld
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes
+ echo Hallo Wereld
substitution of path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes' succeeded
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes
PASS: substitutes.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4xpb01ha5a3am57y1nvnl61w32l95qfy-substitutes-2.drv
opening database environment
attempting write lock on `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/db/access_lock'
write lock granted
downgrading to read lock on `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/db/access_lock'
closing database environment
decremented accessor count to 0
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/substituter2.sh'
+ echo /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 Hallo Wereld
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 Hallo Wereld
+ exit 1
substitution of path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/substituter2.sh' failed: builder for `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2' failed with exit code 1
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/substituter.sh'
+ echo /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 Hallo Wereld
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2 Hallo Wereld
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2
+ echo Hallo Wereld
substitution of path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2' succeeded
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2
PASS: substitutes2.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
derivation is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/mlqnp9va034wk7ssp3zdji5p8ldslm8w-fall-back.drv
output path is /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/../no-such-program'
substitute error: executing `/private/tmp/nix-23147-0/nix-0.9/tests/../no-such-program': No such file or directory
substitution of path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/../no-such-program' failed: builder for `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back' failed with exit code 1
path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back' is required, but it has no (remaining) substitutes
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back'
+ echo PATH=/path-not-set
PATH=/path-not-set
+ mkdir foo
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/svxjg2wyqsf97kw0pxwy8aj95gaj90q8-simple.builder.sh: line 4: mkdir: command not found
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back
+ echo 'Hello World!'
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back
PASS: fallback.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
pushing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
instantiating store expressions...
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
creating archives...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ss0l0wig945gl0i19j9agp8brp5c5jjd-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ss0l0wig945gl0i19j9agp8brp5c5jjd-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/kkd57gmys3aym329wq42cridxrdqnliv-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1 into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/kkd57gmys3aym329wq42cridxrdqnliv-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/91i8bdbmcqy9b9g1b1p3x31chh90fidq-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/91i8bdbmcqy9b9g1b1p3x31chh90fidq-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/42nrm4cz97gp0z53d6mas74sb4q518d6-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/42nrm4cz97gp0z53d6mas74sb4q518d6-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/23nr1mmx2ikw27v8y3p7d8iggih9rpjk-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lxxl5rcddh7z1flijdj871667vwpg5f1-dependencies.builder2.sh into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/23nr1mmx2ikw27v8y3p7d8iggih9rpjk-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cvzqvf85xzn4qm4lfw8yk4b7dwydrzak-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cvzqvf85xzn4qm4lfw8yk4b7dwydrzak-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/iayg2n1ngv4379j7305cmms74d5q8q78-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2 into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/iayg2n1ngv4379j7305cmms74d5q8q78-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/2af30xihw4hqz3zffqfikqzlfy7g3zw7-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/y45vb61ak462sw7ic237swbn1cv9n5zf-dependencies.builder0.sh into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/2af30xihw4hqz3zffqfikqzlfy7g3zw7-nar...
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/svx0hswyg5v7ql03d8p7d7vbhxs8llnx-nar'
packing /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh into /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/svx0hswyg5v7ql03d8p7d7vbhxs8llnx-nar...
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
creating manifest...
uploading archives...
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cvzqvf85xzn4qm4lfw8yk4b7dwydrzak-nar/00ycnas879kfic257yfd4r2n86kbk9wvws6ky3p1x4al5saczzs5.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/2af30xihw4hqz3zffqfikqzlfy7g3zw7-nar/09nyk0shxxhn4jql3rmnk8kb9pgj1m4v8mv23lg945dpsizycnpj.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/91i8bdbmcqy9b9g1b1p3x31chh90fidq-nar/0gnaj19cbkvb3b5w1xaf6jhp5i3v03zzlvggwli55xs2ipz2lhqa.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/svx0hswyg5v7ql03d8p7d7vbhxs8llnx-nar/06qj4zw1c3psm2yrzy89jx5mkai13dld015bxy5vhmhilccpvqm5.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/kkd57gmys3aym329wq42cridxrdqnliv-nar/1xh9nfkzddq0lv4a2gprbyjhx5qnrprxb5cd0zzrrmxsbrxnnicz.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ss0l0wig945gl0i19j9agp8brp5c5jjd-nar/03wzlc6phdilk1krbd6ajb5dxhwbhi2d1x4ynpj550n7p6f15qb2.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/42nrm4cz97gp0z53d6mas74sb4q518d6-nar/0gijcf6a3lnbvm7c34i1314xyc1vhx1kg5k0b9r0hvf4q58mcx7m.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/23nr1mmx2ikw27v8y3p7d8iggih9rpjk-nar/117hc4k45f9szggcif6mz7j1sn6yliqbc7jxmgwm05a7pih31a7l.nar.bz2
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/iayg2n1ngv4379j7305cmms74d5q8q78-nar/14yvh69vw9wfsnr8gpwcz8fd97di46cfr6zzgci9xj5h9kg243cf.nar.bz2
uploading manifest...
PASS: nix-push.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/xs9kaz61ni537v7qffl995kb1mmlgndl-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wv88cvsz7jflp422xi7py32w0fcysjgv-parallel'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/wiij2nm3iicxbdagcx600kyhbhllvgn8-parallel'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/vficjbfbdr3i9qhh5n44wyr7bi7ibgdr-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/v403rwspia2nxwr265vk784n68gacxrq-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/svx0hswyg5v7ql03d8p7d7vbhxs8llnx-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ss0l0wig945gl0i19j9agp8brp5c5jjd-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/priqziip0lrnnk2gz6nj5adgkrhxk1px-locking'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/mlqnp9va034wk7ssp3zdji5p8ldslm8w-fall-back.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lvijl9gjqhw9d9sisd05jf6fzfm1lpi9-build-hook'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lrmb22nfp3crv9vnrlb6z28bn8i3l2qk-parallel.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/phpzcm3y6hy3vwnqknszkn3jpl8l94j8-parallel.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/pbdb6vay6dksql9x71j3a8qxbnjqalc7-parallel.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lqjbygib0iazjskdqrq5qgy5ibmimpdl-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lkr8156x5ga57rmry4hqjdhinji6g18b-parallel.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lh2ljcxjw32h71cn3yc91x5rwbcfpb7c-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/l5z7bilix4rm8ifzdvvbhmi56x6jzjmp-substitutes.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/kkd57gmys3aym329wq42cridxrdqnliv-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/ilv87w3r14yincymkwj9yv8r7fvfzy8g-locking'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/iayg2n1ngv4379j7305cmms74d5q8q78-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/hxzs0qaslrsziqyqj4ab93bazm1d9nr7-fall-back'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/gd1pimymhi4ymwpr191ay7vpk5lcpfmw-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/gbfjyghlfa2crqi3kmsf3p4hypmmh3gj-parallel.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/s0bvzjsw4n7clla95hn0izjdfmzm22dk-parallel.builder.sh'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/g9i10jz06p8qai0xx1iqafhpj8rwkh3n-substitutes-2'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/fczprbqx7mj3ifrfn2c7igfx20jw82z4-locking.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/qy2m3rl2plxm78h7gkns0yj7qwzgdg0g-locking.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/mibpdxq9dlinzs01b4fa9bp8lr3sxy41-locking.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/fazlfhs5gliwjwxawxjpi4z09aapqhry-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/f291wk4zx7kjg8sfl1nvmagypfq7d8ci-parallel'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/f0lbmjlh7hjfmdhi7vzcfrpvnq4bgr28-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cvzqvf85xzn4qm4lfw8yk4b7dwydrzak-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cryai9cyvl626jdjm0jnp1nkqa9bjq0a-build-hook-input-1'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/acwl2nn7b6d3g7zmani6hq9y6ag6abw5-parallel'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/91i8bdbmcqy9b9g1b1p3x31chh90fidq-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8h6c5jaxa160bm4ps46qm0clm6hcqa1p-nar.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/fp8hxr3zhnqbv2zm4yqrz8d9i3qcnb60-nar.sh'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8c43ijggc5jx1qvffc9lp0s9349a7d2i-locking'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7lmxg23f0lpwqcyjxqm75rnsbs3pzc12-simple'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/731whws36hv4ylm4k44xiav3108jlv0d-build-hook.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/y45vb61ak462sw7ic237swbn1cv9n5zf-dependencies.builder0.sh'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7jp8csmf9iiv048ajajpii1bq2db0z58-build-hook-input-1.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/6i2j4mfvbmcc973a94xd4mn9nl525hx3-build-hook-input-2.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lxxl5rcddh7z1flijdj871667vwpg5f1-dependencies.builder2.sh'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/61lygdck4nnm1dagy1731h4d6r0xxlnq-simple.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4xpb01ha5a3am57y1nvnl61w32l95qfy-substitutes-2.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/svxjg2wyqsf97kw0pxwy8aj95gaj90q8-simple.builder.sh'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4vhmgsffcchzxbki669y35rxqyv1bll1-parallel'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/42nrm4cz97gp0z53d6mas74sb4q518d6-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/3xsbmh10y0jvv02l6y5lsd4fdksg1m72-locking.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9qmkzk6n6pz3kli4ilkisg13596jdccw-locking.drv'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/rlag34lwx6xjb8skriwjm46irfvpqp8c-locking.builder.sh'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/3kda5g5vvka63izpa54grfylzggdd6sb-locking'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/2af30xihw4hqz3zffqfikqzlfy7g3zw7-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/23nr1mmx2ikw27v8y3p7d8iggih9rpjk-nar'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w4i7c40f5lsn4lany99b6km5wfz7rph-substitutes'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1bp7fx67g0kjlf06h5cdhsdkdlbymdlr-build-hook-input-2'
deleting `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/0ycdhpkvc9f5dwbkk6aqii1ldvps3cqs-locking'
FOOBAR
BAR
cat: /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv: No such file or directory
PASS: gc.sh
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1
+ echo FOO
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent'
| executing builder `//bin/sh'
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1/foo
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2/bar
+ echo FOOBAR
+ sleep 5
opening database environment
attempting write lock on `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/db/access_lock'
write lock refused
acquiring read lock on `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/db/access_lock'
incremented accessor count to 2
acquiring global GC lock `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/gc.lock'
looking at `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/gcroots'
looking at `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/gcroots/foo'
found root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies' in `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/gcroots/foo'
looking at `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/gcroots/foo2'
found root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/klncmv9gv4ay8aipcfsdm5md5w5rnq7k-gc-concurrent2.drv' in `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/gcroots/foo2'
reading temporary root file `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/temproots/5607'
waiting for read lock on `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/var/nix/temproots/5607'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1nhf0zjqnl0blnm28lygz9ksv107bcsb-gc-concurrent.drv'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c3imjiijy52l56w7cz2mj2mi4kr041id-gc-concurrent.builder.sh'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
got temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/klncmv9gv4ay8aipcfsdm5md5w5rnq7k-gc-concurrent2.drv'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/klncmv9gv4ay8aipcfsdm5md5w5rnq7k-gc-concurrent2.drv'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/yijdbdg3x02dicbq8p3kg30kjwdvsy3y-gc-concurrent2.builder.sh'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/yijdbdg3x02dicbq8p3kg30kjwdvsy3y-gc-concurrent2.builder.sh'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent.lock'
dead path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent.lock'
skipping active lock `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent.lock'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent'
temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1nhf0zjqnl0blnm28lygz9ksv107bcsb-gc-concurrent.drv'
temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1nhf0zjqnl0blnm28lygz9ksv107bcsb-gc-concurrent.drv'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c3imjiijy52l56w7cz2mj2mi4kr041id-gc-concurrent.builder.sh'
temporary root `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c3imjiijy52l56w7cz2mj2mi4kr041id-gc-concurrent.builder.sh'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lxxl5rcddh7z1flijdj871667vwpg5f1-dependencies.builder2.sh'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lxxl5rcddh7z1flijdj871667vwpg5f1-dependencies.builder2.sh'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv'
considering deletion of `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh'
live path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh'
closing database environment
decremented accessor count to 2
building path(s) `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w8xxgf41f6p4hrzx07wzx1krmz9sn11-gc-concurrent2'
| executing builder `//bin/sh'
waiting for pid 5607 to finish...
+ export PATH=/bin:/usr/bin:/path-not-set
+ PATH=/bin:/usr/bin:/path-not-set
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w8xxgf41f6p4hrzx07wzx1krmz9sn11-gc-concurrent2
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/4x2mr1jnsy881qkwqrj0w0allq9j815n-dependencies-input-1/foo
++ cat /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2/bar
+ echo FOOBARxyzzy
+ test -e /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w8xxgf41f6p4hrzx07wzx1krmz9sn11-gc-concurrent2.lock
+ sleep 3
+ mkdir /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent
mkdir: /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent: File exists
+ true
+ test -e /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent.lock
+ ln -s /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2 /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent/input-2
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent'
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/cfpnwyvkwz6rn0wpcqlg1c383054il0z-gc-concurrent
waiting for pid 5608 to finish...
scanning for references inside `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w8xxgf41f6p4hrzx07wzx1krmz9sn11-gc-concurrent2'
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/1w8xxgf41f6p4hrzx07wzx1krmz9sn11-gc-concurrent2
FOOBAR
BAR
FOOBARxyzzy
PASS: gc-concurrent.sh
PASS: verify.sh
clearing store...
upgrading Nix store to new schema (this may take a while)...
hashing paths...
processing closures...
pulling cache...
obtaining list of Nix archives at file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/manifest...
registering substitutes...
9 store paths in manifest
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
building /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies using substitutes...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/14yvh69vw9wfsnr8gpwcz8fd97di46cfr6zzgci9xj5h9kg243cf.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 138 100 138 0 0 145k 0 --:--:-- --:--:-- --:--:-- 145k
100 138 100 138 0 0 33527 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/0gnaj19cbkvb3b5w1xaf6jhp5i3v03zzlvggwli55xs2ipz2lhqa.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 342 100 342 0 0 408k 0 --:--:-- --:--:-- --:--:-- 408k
100 342 100 342 0 0 82270 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies
BAR
clearing store...
upgrading Nix store to new schema (this may take a while)...
hashing paths...
processing closures...
pulling cache...
obtaining list of Nix archives at file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/manifest...
registering substitutes...
9 store paths in manifest
building /private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv using substitutes...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/y45vb61ak462sw7ic237swbn1cv9n5zf-dependencies.builder0.sh' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/y45vb61ak462sw7ic237swbn1cv9n5zf-dependencies.builder0.sh'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/09nyk0shxxhn4jql3rmnk8kb9pgj1m4v8mv23lg945dpsizycnpj.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/y45vb61ak462sw7ic237swbn1cv9n5zf-dependencies.builder0.sh'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 223 100 223 0 0 128k 0 --:--:-- --:--:-- --:--:-- 128k
100 223 100 223 0 0 45315 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/06qj4zw1c3psm2yrzy89jx5mkai13dld015bxy5vhmhilccpvqm5.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/9l938dfgn13f59x2p1qdhgr2pysv0qv6-dependencies.builder1.sh'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 154 100 154 0 0 188k 0 --:--:-- --:--:-- --:--:-- 188k
100 154 100 154 0 0 36346 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lxxl5rcddh7z1flijdj871667vwpg5f1-dependencies.builder2.sh' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lxxl5rcddh7z1flijdj871667vwpg5f1-dependencies.builder2.sh'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/117hc4k45f9szggcif6mz7j1sn6yliqbc7jxmgwm05a7pih31a7l.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/lxxl5rcddh7z1flijdj871667vwpg5f1-dependencies.builder2.sh'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 152 100 152 0 0 187k 0 --:--:-- --:--:-- --:--:-- 187k
100 152 100 152 0 0 37091 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/00ycnas879kfic257yfd4r2n86kbk9wvws6ky3p1x4al5saczzs5.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/7hxpmqdlwp75pwyc8vwpbkbjvnjf4qrp-dependencies-input-1.drv'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 355 100 355 0 0 120k 0 --:--:-- --:--:-- --:--:-- 120k
100 355 100 355 0 0 58609 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/0gijcf6a3lnbvm7c34i1314xyc1vhx1kg5k0b9r0hvf4q58mcx7m.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8p20hig465ifvlxyh86ksi4xzbvg00ym-dependencies-input-2.drv'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 363 100 363 0 0 83218 0 --:--:-- --:--:-- --:--:-- 83218
100 363 100 363 0 0 48104 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/03wzlc6phdilk1krbd6ajb5dxhwbhi2d1x4ynpj550n7p6f15qb2.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/k03vzpppcbx872a52xhrz0v795bfrbpy-dependencies.drv'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 522 100 522 0 0 81511 0 --:--:-- --:--:-- --:--:-- 81511
100 522 100 522 0 0 54329 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/14yvh69vw9wfsnr8gpwcz8fd97di46cfr6zzgci9xj5h9kg243cf.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/8apn3a9cnwssm7xs1pm0phx11cvsr2sz-dependencies-input-2'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 138 100 138 0 0 83636 0 --:--:-- --:--:-- --:--:-- 83636
100 138 100 138 0 0 25049 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
substituting path `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies' using substituter `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/bin/nix/download-using-manifests.pl'
*** Trying to download/patch `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
*** Step 1/1: downloading `file:///private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/cache/0gnaj19cbkvb3b5w1xaf6jhp5i3v03zzlvggwli55xs2ipz2lhqa.nar.bz2' into `/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies'
downloading archive...
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
100 342 100 342 0 0 93750 0 --:--:-- --:--:-- --:--:-- 93750
100 342 100 342 0 0 49450 0 --:--:-- --:--:-- --:--:-- 0
unpacking archive...
warning: you did not specify `--add-root'; the result might be removed by the garbage collector
/private/tmp/nix-23147-0/nix-0.9/tests/test-tmp/store/c8fq9rnmjpm4wkx7f1g6s7hqvrq4sccn-dependencies
BAR
PASS: nix-pull.sh
===================
All 16 tests passed
===================
make[1]: Nothing to be done for `check-am'.