test log showing output of failing test

LastTest.log (text/plain), 100.26 KB, created by Jonathan Lovelace on 2016-12-24 18:47:10 UTC

Start testing: Dec 24 00:07 EST
----------------------------------------------------------
1/37 Testing: test_bucket
1/37 Test: test_bucket
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/bucket/test_bucket"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/bucket
"test_bucket" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
all tests passed OK
<end of output>
Test time =   0.11 sec
----------------------------------------------------------
Test Passed.
"test_bucket" end time: Dec 24 00:07 EST
"test_bucket" time elapsed: 00:00:00
----------------------------------------------------------

2/37 Testing: bvhtest
2/37 Test: bvhtest
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/bvh/bvhtest"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/bvh
"bvhtest" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"bvhtest" end time: Dec 24 00:07 EST
"bvhtest" time elapsed: 00:00:00
----------------------------------------------------------

3/37 Testing: http
3/37 Test: http
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/test_http"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io
"http" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
testing chunked transfer encoding
sending error 404 for /not-found
	content:
done 404 test
done1
channel close
dtor test server channel
done2
channel close
dtor test server channel
done3
testing abrupt close
CURL Result:6 Couldn't resolve host name
HTTP request: set failure:6 reason Couldn't resolve host name
channel close
dtor test server channel
testing proxy close
CURL Result:52 Server returned nothing (no headers, no data)
HTTP request: set failure:52 reason Server returned nothing (no headers, no data)
testing HTTP 1.1 pipelining
dtor test server channel
http 1.0 multiple requests
channel close
dtor test server channel
channel close
dtor test server channel
channel close
dtor test server channel
testing POST
testing PUT
sending PUT response
testing PUT create
sending create response
zero-length-content-response
cancel  request
dtor test server channel
HTTP request: set failure:-1 reason my reason 1
HTTP request: set failure:-1 reason my reason 2
cancel middle request
dtor test server channel
HTTP request: set failure:-1 reason middle request
get-during-response-send
channel close
dtor test server channel
CURL Result:56 Failure when receiving data from the peer
HTTP request: set failure:56 reason Failure when receiving data from the peer
<end of output>
Test time =   4.43 sec
----------------------------------------------------------
Test Failed.
"http" end time: Dec 24 00:07 EST
"http" time elapsed: 00:00:04
----------------------------------------------------------

4/37 Testing: dns
4/37 Test: dns
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/test_dns"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io
"dns" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
all tests passed ok
<end of output>
Test time =   1.07 sec
----------------------------------------------------------
Test Passed.
"dns" end time: Dec 24 00:07 EST
"dns" time elapsed: 00:00:01
----------------------------------------------------------

5/37 Testing: binobj
5/37 Test: binobj
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/test_binobj"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io
"binobj" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
<end of output>
Test time =  10.71 sec
----------------------------------------------------------
Test Passed.
"binobj" end time: Dec 24 00:07 EST
"binobj" time elapsed: 00:00:10
----------------------------------------------------------

6/37 Testing: http_repository
6/37 Test: http_repository
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/test_repository"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io
"http_repository" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Dir::children: opendir failed:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic"
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB" child update took:0
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirC" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA"
scheduling update for fileAAA
scheduling update for fileAAB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA/subdirA" child update took:0
scheduling update for fileBAA
scheduling update for fileBAB
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirB" child update took:0
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirC/subdirA" child update took:0
got file fileAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA/subdirA"
got file fileAAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA/subdirA"
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirA"
got file fileBAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirB"
scheduling update for fileCAAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirC/subdirA/subsubA" child update took:0
got file fileCAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirC/subdirA/subsubA"
hash mismatch'dirA
file exists but hash is wrong for:dirA
on disk:7ac9803d0f4eb27dd61879a6874ea6675d0d47e1 vs in info:43fb80daedf0e26bdd5d196443e044f3892ff260
hash mismatch'dirB
file exists but hash is wrong for:dirB
on disk:8297f86083ff4161ff2a01b76a4dd163b9d15d3a vs in info:4621fa0840bd95882249c13ffb53e3c51c450ad9
hash mismatch'dirC
file exists but hash is wrong for:dirC
on disk:129f1b565aeee82c1bc8567d403bf85342f818e1 vs in info:c85c5c6395510dc7c96eeefd02d180dcbaea7a9c
hash mismatch'fileA
file exists but hash is wrong for:fileA
on disk:daf74d0f8faff014e73db59a88ad489bd26d9798 vs in info:7894a9772a8371b2e47f3eb1abe5348b2312728d
file exists hash is good:fileB
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for fileA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic" child update took:0
file exists hash is good:fileAA
file exists hash is good:fileAB
file exists hash is good:fileAC
is orphan 'subdirA'
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirA" child update took:0
hash mismatch'subdirA
file exists but hash is wrong for:subdirA
on disk:cf07ece2c6fcd4a98c9738a9f75d80c40d2f6846 vs in info:0d3b7343b632e1346b2d049812c6ce583aa6222b
file exists hash is good:subdirB
file exists hash is good:fileBBA
file exists hash is good:fileBBB
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB" child update took:0
file exists hash is good:subdirA
file exists hash is good:subsubA
file exists hash is good:fileCAAA
scheduling update for fileCA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirC" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic"
hash mismatch'fileBAA
file exists but hash is wrong for:fileBAA
on disk:26878ce6c61a49635f5bcd6eb6315a1c8157623e vs in info:03964adeb4fee521d6c22268865ff0aa3df9a949
is orphan 'fileBAB'
file exists hash is good:fileBAC
scheduling update for fileBAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirA" child update took:0
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirC"
Passed test: basic clone and update
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_basic/dirB/subdirA"
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB" child update took:0
scheduling update for fileCA
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirC" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirA"
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB/subdirB" child update took:0
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirC"
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirC/subdirA" child update took:0
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB/subdirB"
scheduling update for fileCAAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirC/subdirA/subsubA" child update took:0
got file fileCAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirC/subdirA/subsubA"
file exists hash is good:dirA
file exists hash is good:fileAA
file exists hash is good:fileAB
file exists hash is good:fileAC
file exists hash is good:dirB
file exists hash is good:subdirA
hash mismatch'fileBAA
file exists but hash is wrong for:fileBAA
on disk:86263d699907d6d1a440881c5268e8bb2fbd4367 vs in info:03964adeb4fee521d6c22268865ff0aa3df9a949
file exists hash is good:fileBAC
scheduling update for fileBAA
file exists hash is good:subdirB
file exists hash is good:fileBBA
file exists hash is good:fileBBB
file exists hash is good:dirC
file exists hash is good:fileCA
file exists hash is good:subdirA
file exists hash is good:subsubA
file exists hash is good:fileCAAA
file exists hash is good:fileA
file exists hash is good:fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2" child update took:69
Passed test: identify and fix locally modified files
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_modify_local_2/dirB/subdirA"
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB" child update took:0
scheduling update for fileCA
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirC" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirA"
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirB" child update took:0
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirC"
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirC/subdirA" child update took:0
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirB"
scheduling update for fileCAAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirC/subdirA/subsubA" child update took:0
got file fileCAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirC/subdirA/subsubA"
file exists hash is good:dirA
file exists hash is good:fileAA
file exists hash is good:fileAB
file exists hash is good:fileAC
file exists hash is good:dirB
file exists hash is good:subdirB
file exists hash is good:fileBBA
file exists hash is good:fileBBB
scheduling update for subdirA
file exists hash is good:dirC
file exists hash is good:fileCA
file exists hash is good:subdirA
file exists hash is good:subsubA
file exists hash is good:fileCAAA
file exists hash is good:fileA
file exists hash is good:fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local" child update took:0
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirA" child update took:0
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirA"
Passed test: lose and replace local files
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_lose_local/dirB/subdirA"
hash mismatch'dirC
hash mismatch'dirD
scheduling update for dirC
scheduling update for dirD
scheduling update for dirA
scheduling update for dirB
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing" child update took:0
file exists hash is good:fileCB
hash mismatch'fileCC
file exists but hash is wrong for:fileCC
on disk:7c0f643545c2d6fba1d39bb623ad8da13d725bdf vs in info:e2b1c72ba9c4b6e269170ec8e4a4bbe3250e482e
scheduling update for fileCC
scheduling update for fileCA
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirC" child update took:0
file exists hash is good:fileDA
hash mismatch'subdirDA
hash mismatch'subdirDB
scheduling update for subdirDA
scheduling update for subdirDB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirD" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirB" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing"
got file fileCC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirC"
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirC"
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirC/subdirA" child update took:0
file exists hash is good:fileDAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirD/subdirDA" child update took:0
file exists hash is good:fileDBA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirD/subdirDB" child update took:0
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirA"
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirB/subdirB" child update took:0
scheduling update for fileCAAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirC/subdirA/subsubA" child update took:0
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirB/subdirB"
Passed test: merge existing files with matching hash
got file fileCAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_merge_existing/dirC/subdirA/subsubA"
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for dirD
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
scheduling update for subdirE
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirB" child update took:0
scheduling update for fileCA
scheduling update for fileCB
scheduling update for fileCC
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirC" child update took:0
scheduling update for fileDA
scheduling update for subdirDA
scheduling update for subdirDB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirD" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirA"
scheduling update for fileAEA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirA/subdirE" child update took:0
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirB/subdirB" child update took:0
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirC"
got file fileCB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirC"
got file fileCC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirC"
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirC/subdirA" child update took:0
sending error 404 for /repo/dirA/subdirE/fileAEA
	content:entry marked to fail explicitly:dirA/subdirE/fileAEA
got file fileDA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirD"
scheduling update for fileDAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirD/subdirDA" child update took:0
scheduling update for fileDBA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirD/subdirDB" child update took:0
terrasync file not found on server: fileAEA for Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirA/subdirE"
failed to update entry:Path "dirA/subdirE/fileAEA" code:7
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirB/subdirB"
scheduling update for fileCAAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirC/subdirA/subsubA" child update took:0
got file fileDAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirD/subdirDA"
got file fileDBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirD/subdirDB"
got file fileCAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_missing_files/dirC/subdirA/subsubA"
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for dirD
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
scheduling update for subdirE
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
scheduling update for subdirG
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB" child update took:0
scheduling update for fileCA
scheduling update for fileCB
scheduling update for fileCC
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirC" child update took:0
scheduling update for fileDA
scheduling update for subdirDA
scheduling update for subdirDB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirD" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirA"
scheduling update for fileAEA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirA/subdirE" child update took:0
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirB" child update took:0
scheduling update for fileBGA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirG" child update took:0
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirC"
got file fileCB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirC"
got file fileCC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirC"
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirC/subdirA" child update took:0
got file fileDA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirD"
scheduling update for fileDAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirD/subdirDA" child update took:0
scheduling update for fileDBA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirD/subdirDB" child update took:0
got file fileAEA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirA/subdirE"
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirB"
channel close
dtor test server channel
Passed test: detect corrupted download
HTTP request: set failure:-1 reason Repository updated failed
failed to update entry:Path "dirC/subdirA/subsubA" code:2
HTTP request: set failure:-1 reason Repository updated failed
failed to update entry:Path "dirD/subdirDA/fileDAA" code:2
HTTP request: set failure:-1 reason Repository updated failed
failed to update entry:Path "dirD/subdirDB/fileDBA" code:2
failed to update repository:http://localhost:2000/repo, possibly modified during sync
failed to update entry:Path "dirB/subdirG" code:6
got file fileBGA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_corrupt_files/dirB/subdirG"
scheduling update for dirA
scheduling update for dirB
scheduleUpdate, child:dirB is marked do not update so skipping
scheduling update for dirC
scheduleUpdate, child:dirC is marked do not update so skipping
scheduling update for dirD
scheduleUpdate, child:dirD is marked do not update so skipping
scheduling update for dirG
scheduleUpdate, child:dirG is marked do not update so skipping
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
scheduling update for subdirE
scheduleUpdate, child:subdirE is marked do not update so skipping
scheduling update for subdirF
scheduling update for subdirH
scheduleUpdate, child:subdirH is marked do not update so skipping
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA"
scheduling update for fileAFA
scheduling update for fileAFB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirF" child update took:0
got file fileAFA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirF"
got file fileAFB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirF"
scheduling update for subdirA
scheduling update for subdirB
scheduling update for subdirG
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB" child update took:0
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirB" child update took:0
scheduling update for fileBGA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirG" child update took:0
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirB"
got file fileBGA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirB/subdirG"
scheduling update for fileAEA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirE" child update took:0
scheduling update for fileAHA
scheduling update for fileAHB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirH" child update took:0
got file fileAEA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirE"
got file fileAHA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirH"
got file fileAHB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirH"
hash mismatch'dirA
file exists but hash is wrong for:dirA
on disk:a433a4ae2b2f30d01270a05516d3b69911539e2c vs in info:5628eff2bc6a9a118348f0cbb93af0872c4003d3
file exists hash is good:dirB
file exists hash is good:subdirA
file exists hash is good:fileBAA
file exists hash is good:fileBAC
file exists hash is good:subdirB
file exists hash is good:fileBBA
file exists hash is good:fileBBB
file exists hash is good:subdirG
file exists hash is good:fileBGA
file exists hash is good:fileA
file exists hash is good:fileB
scheduling update for dirA
scheduling update for dirC
scheduleUpdate, child:dirC is marked do not update so skipping
scheduling update for dirD
scheduleUpdate, child:dirD is marked do not update so skipping
scheduling update for dirG
scheduleUpdate, child:dirG is marked do not update so skipping
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update" child update took:0
file exists hash is good:fileAA
file exists hash is good:fileAB
file exists hash is good:fileAC
file exists hash is good:subdirE
file exists hash is good:fileAEA
hash mismatch'subdirF
file exists but hash is wrong for:subdirF
on disk:a66c815c1c2e09c5391f9e96bfcb1e4baede28f4 vs in info:c10ea3ffcf22f6650a6949dd729054351a04bea2
file exists hash is good:subdirH
file exists hash is good:fileAHA
file exists hash is good:fileAHB
scheduling update for subdirF
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA" child update took:0
file exists hash is good:fileAFA
file exists hash is good:fileAFB
scheduling update for fileAFC
scheduling update for fileAFD
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirF" child update took:0
got file fileAFC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirF"
Passed test: basic partial clone and update
got file fileAFD in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update/dirA/subdirF"
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for dirD
scheduling update for dirG
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
scheduling update for subdirE
scheduling update for subdirF
scheduling update for subdirH
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
scheduling update for subdirG
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB" child update took:0
scheduling update for fileCA
scheduling update for fileCB
scheduling update for fileCC
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirC" child update took:0
scheduling update for fileDA
scheduling update for subdirDA
scheduling update for subdirDB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirD" child update took:0
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirG" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA"
scheduling update for fileAEA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirE" child update took:0
scheduling update for fileAFA
scheduling update for fileAFB
scheduling update for fileAFC
scheduling update for fileAFD
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirF" child update took:0
scheduling update for fileAHA
scheduling update for fileAHB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirH" child update took:0
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirA" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirB" child update took:0
scheduling update for fileBGA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirG" child update took:0
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirC"
got file fileCB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirC"
got file fileCC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirC"
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirC/subdirA" child update took:0
got file fileDA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirD"
scheduling update for fileDAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirD/subdirDA" child update took:0
scheduling update for fileDBA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirD/subdirDB" child update took:0
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirG/subdirA" child update took:0
got file fileAEA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirE"
got file fileAFA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirF"
got file fileAFB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirF"
got file fileAFC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirF"
got file fileAFD in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirF"
got file fileAHA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirH"
got file fileAHB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirA/subdirH"
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirA"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirB"
got file fileBGA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirB/subdirG"
scheduling update for fileCAAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirC/subdirA/subsubA" child update took:0
got file fileDAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirD/subdirDA"
got file fileDBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirD/subdirDB"
scheduling update for fileGAAB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirG/subdirA/subsubA" child update took:0
got file fileCAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirC/subdirA/subsubA"
got file fileGAAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing/dirG/subdirA/subsubA"
Passed test: partial update of existing
file exists hash is good:dirA
file exists hash is good:fileAA
file exists hash is good:fileAB
file exists hash is good:fileAC
file exists hash is good:subdirE
file exists hash is good:subdirF
file exists hash is good:fileAFA
file exists hash is good:fileAFB
file exists hash is good:fileAFC
file exists hash is good:fileAFD
file exists hash is good:subdirH
file exists hash is good:dirB
file exists hash is good:dirC
file exists hash is good:dirD
file exists hash is good:dirG
file exists hash is good:fileA
file exists hash is good:fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_existing" child update took:0
HTTP request: set failure:-1 reason Repository object deleted
failed to update entry:Path "dirC" code:2
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduleUpdate, child:dirC is marked do not update so skipping
scheduling update for dirD
scheduleUpdate, child:dirD is marked do not update so skipping
scheduling update for dirG
scheduleUpdate, child:dirG is marked do not update so skipping
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
scheduling update for subdirE
scheduleUpdate, child:subdirE is marked do not update so skipping
scheduling update for subdirF
scheduling update for subdirH
scheduleUpdate, child:subdirH is marked do not update so skipping
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA" child update took:0
scheduling update for subdirA
scheduleUpdate, child:subdirA is marked do not update so skipping
scheduling update for subdirB
scheduling update for subdirG
scheduleUpdate, child:subdirG is marked do not update so skipping
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA"
scheduling update for fileAFA
scheduling update for fileAFB
scheduling update for fileAFC
scheduling update for fileAFD
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirF" child update took:0
scheduling update for fileBBA
scheduling update for fileBBB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirB" child update took:0
got file fileAFA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirF"
got file fileAFB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirF"
got file fileAFC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirF"
got file fileAFD in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirF"
got file fileBBA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirB"
got file fileBBB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirB"
scheduling update for fileAEA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirE" child update took:0
scheduling update for fileAHA
scheduling update for fileAHB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirH" child update took:0
scheduling update for fileBAA
scheduling update for fileBAC
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirA" child update took:0
scheduling update for fileBGA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirG" child update took:0
scheduling update for fileCA
scheduling update for fileCB
scheduling update for fileCC
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirC" child update took:0
got file fileAEA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirE"
got file fileAHA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirH"
got file fileAHB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirA/subdirH"
got file fileBAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirA"
got file fileBAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirA"
got file fileBGA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirB/subdirG"
got file fileCA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirC"
got file fileCB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirC"
got file fileCC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirC"
scheduling update for subsubA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirC/subdirA" child update took:0
scheduling update for fileCAAA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirC/subdirA/subsubA" child update took:0
Passed test: partial update with widen
got file fileCAAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_partial_update_widen/dirC/subdirA/subsubA"
scheduling update for dirA
scheduling update for dirB
scheduling update for dirC
scheduling update for dirD
scheduling update for dirG
scheduling update for fileA
scheduling update for fileB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync" child update took:0
scheduling update for fileAA
scheduling update for fileAB
scheduling update for fileAC
scheduling update for subdirE
scheduling update for subdirF
scheduling update for subdirH
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirA" child update took:0
scheduling update for subdirA
scheduling update for subdirB
scheduling update for subdirG
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirB" child update took:0
scheduling update for fileCA
scheduling update for fileCB
scheduling update for fileCC
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirC" child update took:0
Modifying sub-tree
scheduling update for fileDA
scheduling update for subdirDA
scheduling update for subdirDB
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirD" child update took:0
scheduling update for subdirA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirG" child update took:0
got file fileA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync"
got file fileB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync"
got file fileAA in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirA"
got file fileAB in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirA"
got file fileAC in Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirA"
scheduling update for fileAEA
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirA/subdirE" child update took:0
scheduling update for fileAFA
scheduling update for fileAFB
scheduling update for fileAFC
scheduling update for fileAFD
after update of:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/http_repo_server_modify_during_sync/dirA/subdirF" child update took:0
Passed test modify server during sync
Passed test destory during sync
<end of output>
Test time =  15.03 sec
----------------------------------------------------------
Test Passed.
"http_repository" end time: Dec 24 00:07 EST
"http_repository" time elapsed: 00:00:15
----------------------------------------------------------

7/37 Testing: untar
7/37 Test: untar
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io/test_untar"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/io
"untar" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"untar" end time: Dec 24 00:07 EST
"untar" time elapsed: 00:00:00
----------------------------------------------------------

8/37 Testing: math
8/37 Test: math
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/math/math_test"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/math
"math" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
distance is 2143.73
course is 65.8921
lon:-2.03421, lat:0.60418
Successfully passed all tests!
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"math" end time: Dec 24 00:07 EST
"math" time elapsed: 00:00:00
----------------------------------------------------------

9/37 Testing: geometry
9/37 Test: geometry
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/math/geometry_test"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/math
"geometry" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Testing Geometry intersection routines.
Some of these tests can fail due to roundoff problems...
Dont worry if only a few of them fail...
Failed closest point test #15647: not equivalent!
u = 0.778515, v = 0.0767083
testPoint = [ 0.317366, 0.396066, 0.939157 ], testClosest = [ 0.330748, 0.146179, 0.669375 ], closest = [ 0.330738, 0.146168, 0.669385 ]
triangle: v0 = [ 0.759448, 0.73444, 0.145762 ], v1 = [ 0.250225, 0.0453416, 0.758781 ], v2 = [ 0.338871, 0.0593204, 0.750231 ]
Failed closest point test #66119: not equivalent!
u = 0.0772042, v = 0.634777
testPoint = [ 1.04972, 0.932422, 0.199692 ], testClosest = [ 0.240249, 0.638029, 0.212277 ], closest = [ 0.240293, 0.637911, 0.212349 ]
triangle: v0 = [ 0.466416, 0.0321944, 0.587426 ], v1 = [ 0.176731, 0.808789, 0.12122 ], v2 = [ 0.145356, 0.892147, 0.0531344 ]
Failed closest point test #78263: not equivalent!
u = 0.485894, v = 0.26686
testPoint = [ 0.461869, 0.609971, -0.0972598 ], testClosest = [ 0.634772, 0.537093, 0.306911 ], closest = [ 0.635022, 0.537043, 0.306795 ]
triangle: v0 = [ 0.0414984, 0.648636, 0.580824 ], v1 = [ 0.822747, 0.504868, 0.220686 ], v2 = [ 0.842181, 0.492423, 0.210128 ]
Failed ray intersection test #2415: not equivalent!
u = 0.409097, v = 0.541698, t = 1.72704
triangle: v0 = [ 0.266074, 0.259157, 0.893698 ], v1 = [ 0.0341849, 0.042992, 0.401684 ], v2 = [ 0.124748, 0.565437, 0.138337 ]
ray: origin = [ -0.65008, -0.976067, -0.621438 ], direction = [ 0.43122, 0.760088, 0.523831 ]
Failed ray intersection test #62297: not equivalent!
u = 0.336327, v = 0.24187, t = 1.05575
triangle: v0 = [ 0.135646, 0.271864, 0.273476 ], v1 = [ 0.0200945, 0.348835, 0.777282 ], v2 = [ 0.334471, 0.424625, 0.848246 ]
ray: origin = [ -0.875787, -0.0486749, -0.34492 ], direction = [ 0.966765, 0.363131, 0.877917 ]
Failed ray intersection test #65378: not equivalent!
u = 0.698505, v = 0.004599, t = 1.40174
triangle: v0 = [ 0.931936, 0.552563, 0.235164 ], v1 = [ 0.679318, 0.836033, 0.998707 ], v2 = [ 0.728901, 0.744132, 0.800507 ]
ray: origin = [ -0.350676, -0.45943, 0.734907 ], direction = [ 0.788463, 0.863838, 0.0258215 ]
Failed ray intersection test #95183: not equivalent!
u = 0.469009, v = 0.23443, t = 1.97628
triangle: v0 = [ 0.427468, 0.705437, 0.454699 ], v1 = [ 0.00607604, 0.545431, 0.109616 ], v2 = [ 0.533132, 0.900191, 0.0741269 ]
ray: origin = [ -1.67147, -0.00791651, -1.47631 ], direction = [ 0.974599, 0.346088, 0.850054 ]
Failed ray intersection test #83488: not equivalent!
u = 0.260323, v = 0.405192, t = 1.77637
triangle: v0 = [ 0.410397, 0.0504535, 0.948902 ], v1 = [ 0.126766, 0.115452, 0.259869 ], v2 = [ 0.665046, 0.370705, 0.976105 ]
ray: origin = [ -0.556679, -0.347401, -0.438469 ], direction = [ 0.560931, 0.306545, 0.686243 ]
Failed line segment intersection test #90353: not equivalent!
u = 0.381911, v = 0.135416, t = 0.876134
triangle: v0 = [ 0.141525, 0.255598, 0.878091 ], v1 = [ 0.810059, 0.845687, 0.636868 ], v2 = [ 0.932675, 0.818631, 0.964074 ]
line segment: start = [ 0.108437, 0.44778, 0.28127 ], end = [ 0.559901, 0.572673, 0.870608 ]
Failed ray intersection test #90353: not equivalent!
u = 0.381911, v = 0.135416, t = 0.876134
triangle: v0 = [ 0.141525, 0.255598, 0.878091 ], v1 = [ 0.810059, 0.845687, 0.636868 ], v2 = [ 0.932675, 0.818631, 0.964074 ]
ray: origin = [ 0.108437, 0.44778, 0.28127 ], direction = [ 0.451465, 0.124894, 0.589338 ]
Successfully passed all tests!
<end of output>
Test time =   0.47 sec
----------------------------------------------------------
Test Passed.
"geometry" end time: Dec 24 00:07 EST
"geometry" time elapsed: 00:00:00
----------------------------------------------------------

10/37 Testing: CSSBorder
10/37 Test: CSSBorder
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test_CSSBorder"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"CSSBorder" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
all tests passed successfully!
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"CSSBorder" end time: Dec 24 00:07 EST
"CSSBorder" time elapsed: 00:00:00
----------------------------------------------------------

11/37 Testing: tabbed_values
11/37 Test: tabbed_values
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test_tabbed_values"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"tabbed_values" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
all tests passed successfully!
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"tabbed_values" end time: Dec 24 00:07 EST
"tabbed_values" time elapsed: 00:00:00
----------------------------------------------------------

12/37 Testing: streams
12/37 Test: streams
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test_streams"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"streams" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Detection of LF works.
Detection of CR works.
Detection of CR/LF works.
Detection of 2 following CR/LF lines works.
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"streams" end time: Dec 24 00:07 EST
"streams" time elapsed: 00:00:00
----------------------------------------------------------

13/37 Testing: path
13/37 Test: path
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test_path"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"path" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
created:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/temp/foo-afYtgB"
1482556064
Standard Locations:
 - Home:      Path "/var/tmp/portage/dev-games/simgear-2016.3.1/homedir"
 - Desktop:   Path "/var/tmp/portage/dev-games/simgear-2016.3.1/homedir/Desktop"
 - Downloads: Path "/var/tmp/portage/dev-games/simgear-2016.3.1/homedir/Downloads"
 - Documents: Path "/var/tmp/portage/dev-games/simgear-2016.3.1/homedir/Documents"
 - Pictures:  Path "/var/tmp/portage/dev-games/simgear-2016.3.1/homedir/Pictures"
all tests passed OK
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"path" end time: Dec 24 00:07 EST
"path" time elapsed: 00:00:00
----------------------------------------------------------

14/37 Testing: SimpleMarkdown-boost_test
14/37 Test: SimpleMarkdown-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test-simgear_misc-SimpleMarkdown" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"SimpleMarkdown-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.12 sec
----------------------------------------------------------
Test Passed.
"SimpleMarkdown-boost_test" end time: Dec 24 00:07 EST
"SimpleMarkdown-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

15/37 Testing: SVGpreserveAspectRatio-boost_test
15/37 Test: SVGpreserveAspectRatio-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test-simgear_misc-SVGpreserveAspectRatio" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"SVGpreserveAspectRatio-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"SVGpreserveAspectRatio-boost_test" end time: Dec 24 00:07 EST
"SVGpreserveAspectRatio-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

16/37 Testing: strutils-boost_test
16/37 Test: strutils-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test-simgear_misc-strutils" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"strutils-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 4 test cases...

*** No errors detected
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"strutils-boost_test" end time: Dec 24 00:07 EST
"strutils-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

17/37 Testing: utf8tolatin1-boost_test
17/37 Test: utf8tolatin1-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc/test-simgear_misc-utf8tolatin1" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/misc
"utf8tolatin1-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"utf8tolatin1-boost_test" end time: Dec 24 00:07 EST
"utf8tolatin1-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

18/37 Testing: cppbind_ghost-boost_test
18/37 Test: cppbind_ghost-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind/test-simgear_nasal_cppbind-cppbind_ghost" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind
"cppbind_ghost-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 3 test cases...

*** No errors detected
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"cppbind_ghost-boost_test" end time: Dec 24 00:07 EST
"cppbind_ghost-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

19/37 Testing: cppbind_misc-boost_test
19/37 Test: cppbind_misc-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind/test-simgear_nasal_cppbind-cppbind_misc" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind
"cppbind_misc-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.04 sec
----------------------------------------------------------
Test Passed.
"cppbind_misc-boost_test" end time: Dec 24 00:07 EST
"cppbind_misc-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

20/37 Testing: nasal_gc_test-boost_test
20/37 Test: nasal_gc_test-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind/test-simgear_nasal_cppbind-nasal_gc_test" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind
"nasal_gc_test-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"nasal_gc_test-boost_test" end time: Dec 24 00:07 EST
"nasal_gc_test-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

21/37 Testing: nasal_num-boost_test
21/37 Test: nasal_num-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind/test-simgear_nasal_cppbind-nasal_num" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/nasal/cppbind
"nasal_num-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 2 test cases...

*** No errors detected
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"nasal_num-boost_test" end time: Dec 24 00:07 EST
"nasal_num-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

22/37 Testing: props
22/37 Test: props
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/props/test_props"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/props
"props" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------

Value

Testing coercion from bool (expect true)
Bool: true
Int: 1
Float: 1
Double: 1
String: true

Testing coercion from int (expect 128)
Bool: true
Int: 128
Float: 128
Double: 128
String: 128

Testing coercion from float (expect 1.0/3.0)
Bool: true
Int: 0
Float: 0.333333
Double: 0.333333
String: 0.333333

Testing coercion from double (expect 1.0/3.0)
Bool: true
Int: 0
Float: 0.333333
Double: 0.333333
String: 0.3333333333

Testing coercion from string (expect 10e4)
Bool: true
Int: 10
Float: 100000
Double: 100000
String: 10e4

Testing coercion from unspecified (expect -10e-4)
Bool: true
Int: -10
Float: -0.001
Double: -0.001
String: -10e-4

Testing coercion to bool from bool (expect false)
Bool: false
Int: 0
Float: 0
Double: 0
String: false

Testing coercion to bool from int (expect 1)
Bool: true
Int: 1
Float: 1
Double: 1
String: true

Testing coercion to bool from float (expect 1.1)
Bool: true
Int: 1
Float: 1
Double: 1
String: true

Testing coercion to bool from double (expect 1.1)
Bool: true
Int: 1
Float: 1
Double: 1
String: true

Testing coercion to bool from string (expect 1e10)
Bool: true
Int: 1
Float: 1
Double: 1
String: true

Testing coercion to bool from unspecified (expect 1e10)
Bool: true
Int: 1
Float: 1
Double: 1
String: true

Testing tying to a pointer (expect 10)
Bool: true
Int: 10
Float: 10
Double: 10
String: 10

Changing base variable (expect -5)
Bool: true
Int: -5
Float: -5
Double: -5
String: -5

Create a new int value (expect 10)
Bool: true
Int: 10
Float: 10
Double: 10
String: 10

Testing tying to static getter (expect 100)
Bool: true
Int: 100
Float: 100
Double: 100
String: 100

Try changing value with no setter (expect 100)
Bool: true
Int: 100
Float: 100
Double: 100
String: 100

Untie value (expect 100)
Bool: true
Int: 100
Float: 100
Double: 100
String: 100

Try changing value (expect 200)
Bool: true
Int: 200
Float: 200
Double: 200
String: 200

Create a new int value (expect 10)
Bool: true
Int: 10
Float: 10
Double: 10
String: 10

Testing tying to indexed static getter (0.3333...)
Bool: true
Int: 0
Float: 0.333333
Double: 0.333333
String: 0.3333333333

Untie value (expect 0.3333...)
Bool: true
Int: 0
Float: 0.333333
Double: 0.333333
String: 0.3333333333

Try tying to an object without defaults (expect 199)
Bool: true
Int: 199
Float: 199
Double: 199
String: 199

Try untying from object (expect 199)
Bool: true
Int: 199
Float: 199
Double: 199
String: 199

Try tying to an indexed method (expect 199)
Bool: true
Int: 199
Float: 199
Double: 199
String: 199

Change value (expect 50)
Bool: true
Int: 50
Float: 50
Double: 50
String: 50

Try tying to an object with defaults (expect 50)
Bool: true
Int: 50
Float: 50
Double: 50
String: 50

Created root node 
<?xml version="1.0"?>

<PropertyList>
  <foo>
    <bar type="double">100</bar>
    <bar n="1" type="double">200</bar>
    <bar n="2" type="double">300</bar>
    <bar n="3" type="double">400</bar>
  </foo>
  <hack>
    <bar type="double">100</bar>
    <bar n="3" type="double">200</bar>
    <bar n="1" type="double">300</bar>
    <bar n="2" type="double">400</bar>
  </hack>
</PropertyList>
Trying path (expect /foo[0]/bar[0])
Path is /foo[0]/bar[0]

Looking for all /hack[0]/bar children
There are 4 matches
bar[0]
bar[1]
bar[2]
bar[3]

Testing addition of a totally empty node
<?xml version="1.0"?>

<PropertyList>
  <foo>
    <bar type="double">100</bar>
    <bar n="1" type="double">200</bar>
    <bar n="2" type="double">300</bar>
    <bar n="3" type="double">400</bar>
  </foo>
  <hack>
    <bar type="double">100</bar>
    <bar n="3" type="double">200</bar>
    <bar n="1" type="double">300</bar>
    <bar n="2" type="double">400</bar>
  </hack>
  <a>
    <b>
    </b>
  </a>
</PropertyList>

Testing the addChild function 
Created root node 
Testing appending initial child node
<?xml version="1.0"?>

<PropertyList>
  <test>
    <foo>
      <child n="1" type="int">1</child>
      <child n="2" type="int">2</child>
      <child n="4" type="int">4</child>
    </foo>
  </test>
</PropertyList>

ADDED: /test[0]/foo[0]/child[5]

Testing appending child node at first empty index (Skipping 0)
Testing appending child node at first empty index
Testing appending child node
ADDED: /test[0]/foo[0]/first[0]
<?xml version="1.0"?>

<PropertyList>
  <test>
    <foo>
      <child n="1" type="int">1</child>
      <child n="2" type="int">2</child>
      <child n="4" type="int">4</child>
      <child n="5" type="int">5</child>
      <child n="3" type="int">3</child>
      <child type="int">0</child>
      <first type="string">append first</first>
    </foo>
  </test>
</PropertyList>
<end of output>
Test time =   0.06 sec
----------------------------------------------------------
Test Passed.
"props" end time: Dec 24 00:07 EST
"props" time elapsed: 00:00:00
----------------------------------------------------------

23/37 Testing: propertyObject
23/37 Test: propertyObject
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/props/test_propertyObject"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/props
"propertyObject" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
<end of output>
Test time =   0.03 sec
----------------------------------------------------------
Test Passed.
"propertyObject" end time: Dec 24 00:07 EST
"propertyObject" time elapsed: 00:00:00
----------------------------------------------------------

24/37 Testing: easing_functions
24/37 Test: easing_functions
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/props/test_easing_functions"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/props
"easing_functions" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
linear swing easeInSine easeOutSine easeInOutSine easeInQuad easeInCubic easeInQuart easeInQuint easeOutQuad easeOutCubic easeOutQuart easeOutQuint easeInOutQuad easeInOutCubic easeInOutQuart easeInOutQuint easeInExpo easeOutExpo easeInOutExpo easeInCirc easeOutCirc easeInOutCirc easeInBack easeOutBack easeInOutBack easeInElastic easeOutElastic easeInOutElastic easeInBounce easeOutBounce easeInOutBounce 
0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 -0 2.22045e-16 -0 0 0 0 0 0 0 
0.03125 0.00240764 0.00120454 0.0490677 0.00240764 0.000976562 3.05176e-05 9.53674e-07 2.98023e-08 0.0615234 0.0908508 0.119262 0.146785 0.00195312 0.00012207 7.62939e-06 4.76837e-07 0.00121275 0.194755 0.000753033 0.000488401 0.248039 0.000977518 -0.00157925 0.140754 -0.00299362 0.000158296 0.361156 0.000532474 0.0140991 0.00738525 0.00671387 
0.0625 0.00960736 0.00481527 0.0980171 0.00960736 0.00390625 0.000244141 1.52588e-05 9.53674e-07 0.121094 0.176025 0.227524 0.275804 0.0078125 0.000976562 0.00012207 1.52588e-05 0.00150607 0.35158 0.00116134 0.00195504 0.347985 0.00392163 -0.00598723 0.269496 -0.0106553 0.00106495 0.832177 0.00100575 0.0134277 0.029541 0.019043 
0.09375 0.0215298 0.0108235 0.14673 0.0215298 0.00878906 0.000823975 7.72476e-05 7.24196e-06 0.178711 0.255707 0.325484 0.38872 0.0175781 0.0032959 0.000617981 0.000115871 0.00187032 0.477863 0.00179102 0.00440423 0.422742 0.0088677 -0.0127293 0.386721 -0.0210065 0.00185432 1.19981 -0.000463551 0.00384521 0.0664673 0.0311279 
0.125 0.0380602 0.0192147 0.19509 0.0380602 0.015625 0.00195312 0.000244141 3.05176e-05 0.234375 0.330078 0.413818 0.487091 0.03125 0.0078125 0.00195312 0.000488281 0.00232267 0.579552 0.00276214 0.00784326 0.484123 0.0158771 -0.0213107 0.492925 -0.0320683 0.00201149 1.36412 -0.00276214 0.0380859 0.118164 0.0136719 
0.15625 0.0590394 0.0299687 0.24298 0.0590394 0.0244141 0.0038147 0.000596046 9.31323e-05 0.288086 0.399323 0.493178 0.572369 0.0488281 0.0152588 0.00476837 0.00149012 0.00288443 0.661436 0.0042598 0.0122825 0.536736 0.0250411 -0.0312368 0.5886 -0.0418621 0.00110382 1.33567 -0.00110252 0.0575562 0.184631 0.0487061 
0.1875 0.0842652 0.0430597 0.290285 0.0842652 0.0351562 0.0065918 0.00123596 0.000231743 0.339844 0.463623 0.564194 0.645907 0.0703125 0.0263672 0.0098877 0.00370789 0.00358205 0.727373 0.0065695 0.0177354 0.582961 0.0364876 -0.0420129 0.674243 -0.0484093 -0.000927102 1.19278 0.00568936 0.0622559 0.265869 0.101074 
0.21875 0.113495 0.0584559 0.33689 0.113495 0.0478516 0.0104675 0.00228977 0.000500888 0.389648 0.523163 0.627471 0.708962 0.0957031 0.0418701 0.0183182 0.0080142 0.00444839 0.780468 0.0101316 0.0242191 0.624218 0.0503908 -0.0531444 0.750348 -0.0497311 -0.00352915 1.02865 0.00716409 0.0521851 0.361877 0.123901 
0.25 0.146447 0.0761205 0.382683 0.146447 0.0625 0.015625 0.00390625 0.000976562 0.4375 0.578125 0.683594 0.762695 0.125 0.0625 0.03125 0.015625 0.00552427 0.823223 0.015625 0.0317542 0.661438 0.0669873 -0.0641366 0.81741 -0.0438488 -0.00552427 0.911612 -0.0078125 0.0273438 0.472656 0.117188 
0.28125 0.182803 0.0960107 0.427555 0.182803 0.0791016 0.0222473 0.00625706 0.0017598 0.483398 0.628693 0.733123 0.808182 0.158203 0.0889893 0.0500565 0.0281568 0.00686036 0.857651 0.024097 0.0403655 0.695269 0.0866014 -0.0744947 0.875922 -0.0287837 -0.00544269 0.868487 -0.023276 0.0228882 0.598206 0.0809326 
0.3125 0.222215 0.118079 0.471397 0.222215 0.0976562 0.0305176 0.00953674 0.00298023 0.527344 0.675049 0.776596 0.84641 0.195312 0.12207 0.0762939 0.0476837 0.00851959 0.885374 0.0371627 0.0500822 0.726184 0.109688 -0.0837242 0.926381 -0.00255713 -0.00220503 0.88928 1.36534e-17 0.0974121 0.738525 0.0151367 
0.34375 0.264302 0.142271 0.514103 0.264302 0.118164 0.0406189 0.0139627 0.00479969 0.569336 0.717377 0.814528 0.878284 0.236328 0.162476 0.111702 0.0767951 0.0105801 0.907698 0.0573128 0.0609388 0.754544 0.136908 -0.0913304 0.96928 0.0368096 0.00404884 0.94381 0.0553599 0.157166 0.893616 0.130737 
0.375 0.308658 0.16853 0.55557 0.308658 0.140625 0.0527344 0.0197754 0.00741577 0.609375 0.755859 0.847412 0.904633 0.28125 0.210938 0.158203 0.118652 0.013139 0.925675 0.0883883 0.0729752 0.780625 0.169281 -0.0968186 1.00511 0.0912952 0.0113787 1 0.0441942 0.202148 0.969727 0.263672 
0.40625 0.354858 0.196792 0.595699 0.354858 0.165039 0.0670471 0.0272379 0.0110654 0.647461 0.79068 0.875716 0.926206 0.330078 0.268188 0.217903 0.177046 0.0163168 0.94015 0.136313 0.086238 0.80465 0.208519 -0.099694 1.03438 0.162878 0.0161772 1.03643 -0.0963882 0.232361 0.896545 0.367065 
0.4375 0.402455 0.22699 0.634393 0.402455 0.191406 0.0837402 0.0366364 0.0160284 0.683594 0.822021 0.899887 0.943686 0.382812 0.334961 0.293091 0.256454 0.0202631 0.951806 0.210224 0.100782 0.826797 0.257939 -0.0994621 1.05757 0.253538 0.0143282 1.04655 -0.182059 0.247803 0.838135 0.440918 
0.46875 0.450991 0.259049 0.671559 0.450991 0.219727 0.102997 0.0482798 0.0226311 0.717773 0.850067 0.920348 0.957685 0.439453 0.411987 0.386238 0.362098 0.0251639 0.961192 0.32421 0.116669 0.847215 0.326007 -0.0956282 1.07518 0.365252 0.00328455 1.03585 0.0839117 0.248474 0.794495 0.485229 
0.5 0.5 0.292893 0.707107 0.5 0.25 0.125 0.0625 0.03125 0.75 0.875 0.9375 0.96875 0.5 0.5 0.5 0.5 0.03125 0.96875 0.5 0.133975 0.866025 0.5 -0.0876975 1.0877 0.5 -0.015625 1.01562 0.5 0.234375 0.765625 0.5 
0.53125 0.549009 0.328441 0.740951 0.549009 0.282227 0.149933 0.0796518 0.042315 0.780273 0.897003 0.95172 0.977369 0.560547 0.588013 0.613762 0.637902 0.0388081 0.974836 0.67579 0.152785 0.883331 0.673993 -0.0751755 1.09563 0.634748 -0.035854 0.996715 0.916088 0.205505 0.751526 0.514771 
0.5625 0.597545 0.365607 0.77301 0.597545 0.316406 0.177979 0.100113 0.0563135 0.808594 0.91626 0.963364 0.983972 0.617188 0.665039 0.706909 0.743546 0.0481941 0.979737 0.789776 0.173203 0.899218 0.742061 -0.0575673 1.09946 0.746462 -0.0465519 0.985672 1.18206 0.161865 0.752197 0.559082 
0.59375 0.645142 0.404301 0.803208 0.645142 0.352539 0.20932 0.124284 0.0737935 0.834961 0.932953 0.972762 0.988935 0.669922 0.731812 0.782097 0.822954 0.0598502 0.983683 0.863687 0.19535 0.913762 0.791481 -0.0343785 1.09969 0.837122 -0.0364345 0.983823 1.09639 0.103455 0.767639 0.632935 
0.625 0.691342 0.44443 0.83147 0.691342 0.390625 0.244141 0.152588 0.0953674 0.859375 0.947266 0.980225 0.992584 0.71875 0.789062 0.841797 0.881348 0.0743254 0.986861 0.911612 0.219375 0.927025 0.830719 -0.00511426 1.09682 0.908705 2.73067e-17 0.988621 0.955806 0.0302734 0.797852 0.736328 
0.65625 0.735698 0.485897 0.857729 0.735698 0.430664 0.282623 0.185472 0.121716 0.881836 0.959381 0.986037 0.9952 0.763672 0.837524 0.888298 0.923205 0.0923016 0.98942 0.942687 0.245456 0.939061 0.863092 0.0307201 1.09133 0.96319 0.0561897 0.995951 0.94464 0.106384 0.842834 0.869263 
0.6875 0.777785 0.528603 0.881921 0.777785 0.472656 0.324951 0.223404 0.15359 0.902344 0.969482 0.990463 0.99702 0.804688 0.87793 0.923706 0.952316 0.114626 0.99148 0.962837 0.273816 0.949918 0.890312 0.0736192 1.08372 1.00256 0.11072 1.00221 1 0.261475 0.902588 0.984863 
0.71875 0.817197 0.572445 0.903989 0.817197 0.516602 0.371307 0.266877 0.191818 0.920898 0.977753 0.993743 0.99824 0.841797 0.911011 0.949944 0.971843 0.142349 0.99314 0.975903 0.304731 0.959635 0.913399 0.124078 1.07449 1.02878 0.131513 1.00544 1.02328 0.401794 0.977112 0.919067 
0.75 0.853553 0.617317 0.92388 0.853553 0.5625 0.421875 0.316406 0.237305 0.9375 0.984375 0.996094 0.999023 0.875 0.9375 0.96875 0.984375 0.176777 0.994476 0.984375 0.338562 0.968246 0.933013 0.18259 1.06414 1.04385 0.0883883 1.00552 1.00781 0.527344 0.972656 0.882812 
0.78125 0.886505 0.66311 0.941544 0.886505 0.610352 0.476837 0.372529 0.291038 0.952148 0.989532 0.99771 0.999499 0.904297 0.95813 0.981682 0.991986 0.219532 0.995552 0.989868 0.375782 0.975781 0.949609 0.249652 1.05314 1.04973 -0.0286546 1.00353 0.992836 0.638123 0.947815 0.876099 
0.8125 0.915735 0.709715 0.95694 0.915735 0.660156 0.536377 0.435806 0.354093 0.964844 0.993408 0.998764 0.999768 0.929688 0.973633 0.990112 0.996292 0.272627 0.996418 0.99343 0.417039 0.982265 0.963512 0.325757 1.04201 1.04841 -0.192776 1.00093 0.994311 0.734131 0.937744 0.898926 
0.84375 0.940961 0.75702 0.970031 0.940961 0.711914 0.600677 0.506822 0.427631 0.975586 0.996185 0.999404 0.999907 0.951172 0.984741 0.995232 0.99851 0.338564 0.997116 0.99574 0.463264 0.987718 0.974959 0.4114 1.03124 1.04186 -0.335667 0.998896 1.0011 0.815369 0.942444 0.951294 
0.875 0.96194 0.80491 0.980785 0.96194 0.765625 0.669922 0.586182 0.512909 0.984375 0.998047 0.999756 0.999969 0.96875 0.992188 0.998047 0.999512 0.420448 0.997677 0.997238 0.515877 0.992157 0.984123 0.507075 1.02131 1.03207 -0.364119 0.997989 1.00276 0.881836 0.961914 0.986328 
0.90625 0.97847 0.85327 0.989177 0.97847 0.821289 0.744293 0.674516 0.61128 0.991211 0.999176 0.999923 0.999993 0.982422 0.996704 0.999382 0.999884 0.522137 0.99813 0.998209 0.577258 0.995596 0.991132 0.613279 1.01273 1.02101 -0.199813 0.998146 1.00046 0.933533 0.996155 0.968872 
0.9375 0.990393 0.901983 0.995185 0.990393 0.878906 0.823975 0.772476 0.724196 0.996094 0.999756 0.999985 0.999999 0.992188 0.999023 0.999878 0.999985 0.64842 0.998494 0.998839 0.652015 0.998045 0.996078 0.730504 1.00599 1.01066 0.167823 0.998935 0.998994 0.970459 0.986572 0.980957 
0.96875 0.997592 0.950932 0.998795 0.997592 0.938477 0.909149 0.880738 0.853215 0.999023 0.999969 0.999999 1 0.998047 0.999878 0.999992 1 0.805245 0.998787 0.999247 0.751961 0.999512 0.999022 0.859246 1.00158 1.00299 0.638844 0.999842 0.999468 0.992615 0.985901 0.993286 
1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 1 
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"easing_functions" end time: Dec 24 00:07 EST
"easing_functions" time elapsed: 00:00:00
----------------------------------------------------------

25/37 Testing: state_machine
25/37 Test: state_machine
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure/test_state_machine"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure
"state_machine" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1/simgear/structure/state_machine_test.cxx: All tests passed
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"state_machine" end time: Dec 24 00:07 EST
"state_machine" time elapsed: 00:00:00
----------------------------------------------------------

26/37 Testing: expressions
26/37 Test: expressions
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure/test_expressions"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure
"expressions" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1/simgear/structure/expression_test.cxx: All tests passed
<end of output>
Test time =   0.02 sec
----------------------------------------------------------
Test Passed.
"expressions" end time: Dec 24 00:07 EST
"expressions" time elapsed: 00:00:00
----------------------------------------------------------

27/37 Testing: function_list-boost_test
27/37 Test: function_list-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure/test-simgear_structure-function_list" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure
"function_list-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"function_list-boost_test" end time: Dec 24 00:07 EST
"function_list-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

28/37 Testing: shared_ptr-boost_test
28/37 Test: shared_ptr-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure/test-simgear_structure-shared_ptr" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/structure
"shared_ptr-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 2 test cases...

*** No errors detected
<end of output>
Test time =   0.01 sec
----------------------------------------------------------
Test Passed.
"shared_ptr-boost_test" end time: Dec 24 00:07 EST
"shared_ptr-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

29/37 Testing: catalog_test
29/37 Test: catalog_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package/catalog_test"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package
"catalog_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Dir::children: opendir failed:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package/pkg_add_catalog"
creating catalog from:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1/simgear/package/catalogTest1"
Dir::children: opendir failed:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package/pkg_install_with_dep"
Dir::children: opendir failed:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package/pkg_uninstall"
Dir::children: opendir failed:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package/pkg_catalog_remove"
Dir::children: opendir failed:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package/pkg_catalog_refresh_update"
Dir::children: opendir failed:Path "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/package/pkg_install_tar"
Successfully passed all tests!
<end of output>
Test time =   2.13 sec
----------------------------------------------------------
Test Passed.
"catalog_test" end time: Dec 24 00:07 EST
"catalog_test" time elapsed: 00:00:02
----------------------------------------------------------

30/37 Testing: canvas_element-boost_test
30/37 Test: canvas_element-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/canvas/elements/test-simgear_canvas_elements-canvas_element" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/canvas/elements
"canvas_element-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.13 sec
----------------------------------------------------------
Test Passed.
"canvas_element-boost_test" end time: Dec 24 00:07 EST
"canvas_element-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

31/37 Testing: canvas_event-boost_test
31/37 Test: canvas_event-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/canvas/events/test-simgear_canvas_events-canvas_event" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/canvas/events
"canvas_event-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 1 test case...

*** No errors detected
<end of output>
Test time =   0.04 sec
----------------------------------------------------------
Test Passed.
"canvas_event-boost_test" end time: Dec 24 00:07 EST
"canvas_event-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

32/37 Testing: canvas_layout-boost_test
32/37 Test: canvas_layout-boost_test
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/canvas/layout/test-simgear_canvas_layout-canvas_layout" "--catch_system_error=yes"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/canvas/layout
"canvas_layout-boost_test" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
Running 10 test cases...

*** No errors detected
<end of output>
Test time =   0.05 sec
----------------------------------------------------------
Test Passed.
"canvas_layout-boost_test" end time: Dec 24 00:07 EST
"canvas_layout-boost_test" time elapsed: 00:00:00
----------------------------------------------------------

33/37 Testing: metar
33/37 Test: metar
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/environment/test_metar"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/environment
"metar" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
<end of output>
Test time =   0.03 sec
----------------------------------------------------------
Test Passed.
"metar" end time: Dec 24 00:07 EST
"metar" time elapsed: 00:00:00
----------------------------------------------------------

34/37 Testing: parseBlendFunc
34/37 Test: parseBlendFunc
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/material/test_parseBlendFunc"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/material
"parseBlendFunc" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
all tests passed successfully!
<end of output>
Test time =   0.03 sec
----------------------------------------------------------
Test Passed.
"parseBlendFunc" end time: Dec 24 00:07 EST
"parseBlendFunc" time elapsed: 00:00:00
----------------------------------------------------------

35/37 Testing: animations
35/37 Test: animations
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/model/test_animations"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/model
"animations" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
<end of output>
Test time =   0.03 sec
----------------------------------------------------------
Test Passed.
"animations" end time: Dec 24 00:07 EST
"animations" time elapsed: 00:00:00
----------------------------------------------------------

36/37 Testing: BucketBoxTest
36/37 Test: BucketBoxTest
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/tgdb/BucketBoxTest"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/tgdb
"BucketBoxTest" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
<end of output>
Test time =   1.82 sec
----------------------------------------------------------
Test Passed.
"BucketBoxTest" end time: Dec 24 00:07 EST
"BucketBoxTest" time elapsed: 00:00:01
----------------------------------------------------------

37/37 Testing: parse_color
37/37 Test: parse_color
Command: "/var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/util/test_parse_color"
Directory: /var/tmp/portage/dev-games/simgear-2016.3.1/work/simgear-2016.3.1_build/simgear/scene/util
"parse_color" start time: Dec 24 00:07 EST
Output:
----------------------------------------------------------
all tests passed successfully!
<end of output>
Test time =   0.03 sec
----------------------------------------------------------
Test Passed.
"parse_color" end time: Dec 24 00:07 EST
"parse_color" time elapsed: 00:00:00
----------------------------------------------------------

End testing: Dec 24 00:07 EST