python3 ./tests/test_cli.py DEBUG:passlib.utils.compat:loaded lazy attr 'SafeConfigParser': <class 'configparser.ConfigParser'> DEBUG:passlib.utils.compat:loaded lazy attr 'NativeStringIO': <class '_io.StringIO'> DEBUG:passlib.utils.compat:loaded lazy attr 'BytesIO': <class '_io.BytesIO'> INFO:werkzeug: * Running on http://127.0.0.1:5555/ >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/blend_file_template/create_image_single.blend /tmp/bam_test/blend_file_template /tmp/bam_test/blend_template_deps.json create_image_single NONE 123 stdout: b'Error: Not freed memory blocks: 215' stderr: b'' return: 123 >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/blend_file_template/create_blank.blend /tmp/bam_test/blend_file_template /tmp/bam_test/blend_template_deps.json create_blank NONE 123 stdout: b'Error: Not freed memory blocks: 215' stderr: b'' return: 123 >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/blend_file_template/create_from_files.blend /tmp/bam_test/blend_file_template /tmp/bam_test/blend_template_deps.json create_from_files NONE 123 stdout: b'Error: Not freed memory blocks: 215' stderr: b'' return: 123 .>>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/testfile.blend /tmp/bam_test /tmp/bam_test/blend_template_deps.json create_blank NONE 123 stdout: b'Error: Not freed memory blocks: 215' stderr: b'' return: 123 .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'test message' DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/other_file.txt'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'test message', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:13] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 138 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/mysession/other_file.txt' Adding tmp/bam_test/remote_store/svn_checkout/other_file.txt Transmitting file data . Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout other_file.txt --output /tmp/bam_test/local_store/test_project/mysession INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:13] "GET /test_project/file?filepath=other_file.txt&command=checkout HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=other_file.txt&command=checkout HTTP/1.1" 200 None INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/other_file.txt' INFO:webservice: Zip path: '/tmp/tmpei9y0kij.zip' stdout: download: [100%] written: '/tmp/bam_test/local_store/test_project/mysession' stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'test message' stdout: Nothing to commit! stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'test message' DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/testfile.txt'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'test message', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:13] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 136 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/mysession/testfile.txt' Adding tmp/bam_test/remote_store/svn_checkout/testfile.txt Transmitting file data . Committed revision 2. stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'test 1' DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/a.data'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/b_dir'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/c_dir'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/d_dir'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'test 1', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:14] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+1%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+1%22%7D&command=commit HTTP/1.1" 200 766 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/mysession/c_dir/c_subdir/c.data' packing (A): '/tmp/bam_test/local_store/test_project/mysession/b_dir/b.data' packing (A): '/tmp/bam_test/local_store/test_project/mysession/d_dir/d_subdir/d_nested/d.data' packing (A): '/tmp/bam_test/local_store/test_project/mysession/a.data' Adding tmp/bam_test/remote_store/svn_checkout/a.data Adding tmp/bam_test/remote_store/svn_checkout/b_dir Adding tmp/bam_test/remote_store/svn_checkout/b_dir/b.data Adding tmp/bam_test/remote_store/svn_checkout/c_dir Adding tmp/bam_test/remote_store/svn_checkout/c_dir/c_subdir Adding tmp/bam_test/remote_store/svn_checkout/c_dir/c_subdir/c.data Adding tmp/bam_test/remote_store/svn_checkout/d_dir Adding tmp/bam_test/remote_store/svn_checkout/d_dir/d_subdir Adding tmp/bam_test/remote_store/svn_checkout/d_dir/d_subdir/d_nested Adding tmp/bam_test/remote_store/svn_checkout/d_dir/d_subdir/d_nested/d.data Transmitting file data .... Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam status --json stdout: [] stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam status --json stdout: [["M", "a.data"], ["M", "b_dir/b.data"], ["M", "c_dir/c_subdir/c.data"], ["M", "d_dir/d_subdir/d_nested/d.data"]] stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/local_store/test_project/mysession/testfile.blend /tmp/bam_test/local_store/test_project/mysession /tmp/bam_test/blend_template_deps.json create_blank NONE 123 stdout: b'Error: Not freed memory blocks: 215' stderr: b'' return: 123 running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'tests message' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/testfile.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/testfile.blend'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'tests message', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:15] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22tests+message%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22tests+message%22%7D&command=commit HTTP/1.1" 200 138 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/testfile.blend' Adding (bin) tmp/bam_test/remote_store/svn_checkout/testfile.blend Transmitting file data . Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout testfile.blend --output new_out INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:15] "GET /test_project/file?filepath=testfile.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/testfile.blend' INFO:webservice: Zip path: '/tmp/tmpgnnzezoj.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=testfile.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/testfile.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/testfile.blend'... archiving: 1 files copying: b'/tmp/__blendfile_temp__/testfile.blend@' -> <archive> written: b'/tmp/tmpgnnzezoj.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/new_out' stderr: running: cd '/tmp/bam_test/local_store/test_project/new_out' ; bam commit -m 'test deletion' DEBUG:bam_cli:{'testfile.blend': 'D'} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:webservice:{'testfile.blend': 'D'} DEBUG:svn:RUN: ['svn', 'rm', '/tmp/bam_test/remote_store/svn_checkout/testfile.blend'] DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'test deletion', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:15] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+deletion%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+deletion%22%7D&command=commit HTTP/1.1" 200 114 stdout: Now make a zipfile Deleting tmp/bam_test/remote_store/svn_checkout/testfile.blend Committed revision 3. stderr: running: cd '/tmp/bam_test/local_store/test_project/new_out' ; bam ls --json INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:15] "GET /test_project/file_list?path=. HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file_list?path=. HTTP/1.1" 200 173 stdout: [[".svn", "dir"], ["test_project", "dir"]] stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam status stdout: stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'test message' stdout: Nothing to commit! stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam status .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam ls --json INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:15] "GET /test_project/file_list?path=. HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file_list?path=. HTTP/1.1" 200 173 stdout: [[".svn", "dir"], ["test_project", "dir"]] stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'test message' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/subdir/rel/path/house_rel.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/abs/path/house_abs.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/subdir/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/abs'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/subdir'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'test message', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:16] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 642 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/subdir/rel/path/house_rel.blend' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/abs/path/house_abs.blend' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/subdir/house_lib_user.blend' Adding tmp/bam_test/remote_store/svn_checkout/abs Adding tmp/bam_test/remote_store/svn_checkout/abs/path Adding (bin) tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend Adding tmp/bam_test/remote_store/svn_checkout/subdir Adding (bin) tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend Adding tmp/bam_test/remote_store/svn_checkout/subdir/rel Adding tmp/bam_test/remote_store/svn_checkout/subdir/rel/path Adding (bin) tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend Transmitting file data ... Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout subdir/house_lib_user.blend --output /tmp/bam_test/local_store/test_project/mysession INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:16] "GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' INFO:webservice: Zip path: '/tmp/tmps2q1ko8g.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend INFO:path_walker: GRhouse_rel DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_rel, MAMaterial, MECube, OBCube, TETex Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend INFO:path_walker: GRhouse_abs DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_abs, MAMaterial, MECube, OBCube, TETex stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' archiving: 1 files copying: b'/tmp/__blendfile_temp__/_abs/path/house_abs.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/house_lib_user.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/rel/path/house_rel.blend@' -> <archive> written: b'/tmp/tmps2q1ko8g.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/mysession' stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam deps /tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend --json INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: [ ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//_abs/path/house_abs.blend", "/tmp/bam_test/local_store/test_project/mysession/_abs/path/house_abs.blend", "OK"], ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//rel/path/house_rel.blend", "/tmp/bam_test/local_store/test_project/mysession/rel/path/house_rel.blend", "OK"]] stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'just touched' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/rel/path/house_rel.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/_abs/path/house_abs.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'just touched', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:16] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22just+touched%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22just+touched%22%7D&command=commit HTTP/1.1" 200 151 stdout: Remapping: b'//_abs/path/house_abs.blend' -> b'//../abs/path/house_abs.blend' Now make a zipfile packing (M): '/tmp/bam_test/local_store/test_project/.bam/tmp/house_lib_user.blend' packing (M): '/tmp/bam_test/local_store/test_project/.bam/tmp/rel/path/house_rel.blend' packing (M): '/tmp/bam_test/local_store/test_project/.bam/tmp/_abs/path/house_abs.blend' Sending tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend Transmitting file data . Committed revision 3. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout subdir/house_lib_user.blend --output /tmp/bam_test/local_store/test_project/mysession INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:16] "GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' INFO:webservice: Zip path: '/tmp/tmp4vdr21gv.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend INFO:path_walker: GRhouse_rel DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_rel, MAMaterial, MECube, OBCube, TETex Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend INFO:path_walker: GRhouse_abs DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_abs, MAMaterial, MECube, OBCube, TETex stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' archiving: 1 files copying: b'/tmp/__blendfile_temp__/_abs/path/house_abs.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/house_lib_user.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/rel/path/house_rel.blend@' -> <archive> written: b'/tmp/tmp4vdr21gv.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/mysession' stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam deps /tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend --json INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: [ ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//_abs/path/house_abs.blend", "/tmp/bam_test/local_store/test_project/mysession/_abs/path/house_abs.blend", "OK"], ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//rel/path/house_rel.blend", "/tmp/bam_test/local_store/test_project/mysession/rel/path/house_rel.blend", "OK"]] stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/local_store/test_project/mysession/subdir/house_lib_user.blend /tmp/bam_test/local_store/test_project/mysession /tmp/bam_test/blend_template_deps.json create_blank NONE 123 stdout: b'Error: Not freed memory blocks: 215' stderr: b'' return: 123 running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'test message' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/subdir/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/subdir'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'test message', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:18] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22test+message%22%7D&command=commit HTTP/1.1" 200 213 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/subdir/house_lib_user.blend' Adding tmp/bam_test/remote_store/svn_checkout/subdir Adding (bin) tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend Transmitting file data . Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout subdir/house_lib_user.blend --output /tmp/bam_test/local_store/test_project/mysession INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:18] "GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' INFO:webservice: Zip path: '/tmp/tmpsszig0lm.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend'... archiving: 1 files copying: b'/tmp/__blendfile_temp__/house_lib_user.blend@' -> <archive> written: b'/tmp/tmpsszig0lm.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/mysession' stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'new house to remap' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/rel/path/house_rel.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/_abs/path/house_abs.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/abs'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/subdir/rel'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'new house to remap', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:18] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22new+house+to+remap%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22new+house+to+remap%22%7D&command=commit HTTP/1.1" 200 580 stdout: Remapping: b'//_abs/path/house_abs.blend' -> b'//../abs/path/house_abs.blend' Now make a zipfile packing (M): '/tmp/bam_test/local_store/test_project/.bam/tmp/house_lib_user.blend' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/rel/path/house_rel.blend' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/_abs/path/house_abs.blend' Adding tmp/bam_test/remote_store/svn_checkout/abs Adding tmp/bam_test/remote_store/svn_checkout/abs/path Adding (bin) tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend Sending tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend Adding tmp/bam_test/remote_store/svn_checkout/subdir/rel Adding tmp/bam_test/remote_store/svn_checkout/subdir/rel/path Adding (bin) tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend Transmitting file data ... Committed revision 3. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout subdir/house_lib_user.blend --output /tmp/bam_test/local_store/test_project/mysession INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:18] "GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' INFO:webservice: Zip path: '/tmp/tmpanobdf1n.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend INFO:path_walker: GRhouse_rel DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_rel, MAMaterial, MECube, OBCube, TETex Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend INFO:path_walker: GRhouse_abs DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_abs, MAMaterial, MECube, OBCube, TETex stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' archiving: 1 files copying: b'/tmp/__blendfile_temp__/_abs/path/house_abs.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/house_lib_user.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/rel/path/house_rel.blend@' -> <archive> written: b'/tmp/tmpanobdf1n.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/mysession' stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam deps /tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend --json INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: [ ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//_abs/path/house_abs.blend", "/tmp/bam_test/local_store/test_project/mysession/_abs/path/house_abs.blend", "OK"], ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//rel/path/house_rel.blend", "/tmp/bam_test/local_store/test_project/mysession/rel/path/house_rel.blend", "OK"]] stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'just touched' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/rel/path/house_rel.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/_abs/path/house_abs.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'just touched', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:19] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22just+touched%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22just+touched%22%7D&command=commit HTTP/1.1" 200 151 stdout: Remapping: b'//_abs/path/house_abs.blend' -> b'//../abs/path/house_abs.blend' Now make a zipfile packing (M): '/tmp/bam_test/local_store/test_project/.bam/tmp/house_lib_user.blend' packing (M): '/tmp/bam_test/local_store/test_project/.bam/tmp/rel/path/house_rel.blend' packing (M): '/tmp/bam_test/local_store/test_project/.bam/tmp/_abs/path/house_abs.blend' Sending tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend Transmitting file data . Committed revision 4. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout subdir/house_lib_user.blend --output /tmp/bam_test/local_store/test_project/mysession INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:19] "GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' INFO:webservice: Zip path: '/tmp/tmp4t8ynf2n.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=subdir%2Fhouse_lib_user.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/subdir/rel/path/house_rel.blend INFO:path_walker: GRhouse_rel DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_rel, MAMaterial, MECube, OBCube, TETex Library: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/abs/path/house_abs.blend INFO:path_walker: GRhouse_abs DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3950 names DEBUG:blendfile:building #644 types DEBUG:blendfile:building #644 type-lengths DEBUG:blendfile:building #568 structures INFO:path_walker: GRhouse_abs, MAMaterial, MECube, OBCube, TETex stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/subdir/house_lib_user.blend' archiving: 1 files copying: b'/tmp/__blendfile_temp__/_abs/path/house_abs.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/house_lib_user.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/rel/path/house_rel.blend@' -> <archive> written: b'/tmp/tmp4t8ynf2n.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/mysession' stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam deps /tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend --json INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: [ ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//_abs/path/house_abs.blend", "/tmp/bam_test/local_store/test_project/mysession/_abs/path/house_abs.blend", "OK"], ["/tmp/bam_test/local_store/test_project/mysession/house_lib_user.blend", "//rel/path/house_rel.blend", "/tmp/bam_test/local_store/test_project/mysession/rel/path/house_rel.blend", "OK"]] stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend /tmp/bam_test/local_store/test_project/mysession /tmp/bam_test/blend_template_deps.json create_from_file_liblinks /tmp/bam_test/blendfile_create_data.json 123 stdout: b"Info: Read library: '/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend', '//../../../maps/generic.blend'\n[['/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend', 'Scene10', ['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']], ['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend', 'MySpecial', ['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend']], ['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend', 'MyGeneric', []]]\n['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']\n['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend']\n[]\n['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']\n['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend']\n['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']\nError: Not freed memory blocks: 215" stderr: b'' return: 123 running: cd '/tmp/bam_test/local_store/test_project' ; bam deps /tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend --json INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: [ ["/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend", "//maps/special.blend", "/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend", "OK"]] stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'commit shot_01' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/maps'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/shots'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'commit shot_01', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:21] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22commit+shot_01%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22commit+shot_01%22%7D&command=commit HTTP/1.1" 200 800 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/maps/generic.blend' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/shots/01/shot_01.blend' packing (A): '/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend1' packing (A): '/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend1' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/shots/01/maps/special.blend' packing (A): '/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend1' Adding tmp/bam_test/remote_store/svn_checkout/maps Adding (bin) tmp/bam_test/remote_store/svn_checkout/maps/generic.blend Adding (bin) tmp/bam_test/remote_store/svn_checkout/maps/generic.blend1 Adding tmp/bam_test/remote_store/svn_checkout/shots Adding tmp/bam_test/remote_store/svn_checkout/shots/01 Adding tmp/bam_test/remote_store/svn_checkout/shots/01/maps Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend1 Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend1 Transmitting file data ...... Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout shots/01/shot_01.blend --output new_out INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:21] "GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' INFO:webservice: Zip path: '/tmp/tmpua5c90iy.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None Library: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend INFO:path_walker: SCMySpecial DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker: SCMySpecial, WOWorld Library: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/maps/generic.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/maps/generic.blend INFO:path_walker: SCMyGeneric DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker: SCMyGeneric, WOWorld stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' blend: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' archiving: 1 files copying: b'/tmp/__blendfile_temp__/shot_01.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/maps/special.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/_maps/generic.blend@' -> <archive> written: b'/tmp/tmpua5c90iy.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/new_out' stderr: Exists? /tmp/bam_test/local_store/test_project/new_out/shot_01.blend Exists? /tmp/bam_test/local_store/test_project/new_out/maps/special.blend Exists? /tmp/bam_test/local_store/test_project/new_out/_maps/generic.blend running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout shots/01/shot_01.blend --output new_out INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:21] "GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' INFO:webservice: Zip path: '/tmp/tmpmarkjus_.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None Library: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend INFO:path_walker: SCMySpecial DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker: SCMySpecial, WOWorld Library: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/maps/generic.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/maps/generic.blend INFO:path_walker: SCMyGeneric DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker: SCMyGeneric, WOWorld stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' blend: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' archiving: 1 files copying: b'/tmp/__blendfile_temp__/shot_01.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/maps/special.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/_maps/generic.blend@' -> <archive> written: b'/tmp/tmpmarkjus_.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/new_out' stderr: running: cd '/tmp/bam_test/local_store/test_project/new_out' ; bam commit -m 'new abs and rel files' DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/maps_more'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/shots/01/maps_more'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'new abs and rel files', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:21] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22new+abs+and+rel+files%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22new+abs+and+rel+files%22%7D&command=commit HTTP/1.1" 200 363 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/new_out/maps_more/rel.txt' packing (A): '/tmp/bam_test/local_store/test_project/new_out/_maps_more/abs.txt' Adding tmp/bam_test/remote_store/svn_checkout/maps_more Adding tmp/bam_test/remote_store/svn_checkout/maps_more/abs.txt Adding tmp/bam_test/remote_store/svn_checkout/shots/01/maps_more Adding tmp/bam_test/remote_store/svn_checkout/shots/01/maps_more/rel.txt Transmitting file data .. Committed revision 3. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam ls --json INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:21] "GET /test_project/file_list?path=. HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file_list?path=. HTTP/1.1" 200 350 stdout: [[".svn", "dir"], ["maps", "dir"], ["maps_more", "dir"], ["shots", "dir"], ["test_project", "dir"]] stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam ls shots/01/maps_more --json INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:21] "GET /test_project/file_list?path=shots%2F01%2Fmaps_more HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file_list?path=shots%2F01%2Fmaps_more HTTP/1.1" 200 126 stdout: [["rel.txt", "file"]] stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam ls maps_more --json INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:21] "GET /test_project/file_list?path=maps_more HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file_list?path=maps_more HTTP/1.1" 200 117 stdout: [["abs.txt", "file"]] stderr: .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend /tmp/bam_test/local_store/test_project/mysession /tmp/bam_test/blend_template_deps.json create_from_files NONE 123 stdout: b'Error: Not freed memory blocks: 215' stderr: b'' return: 123 running: cd '/tmp/bam_test/local_store/test_project' ; bam deps /tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend --json INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: [ ["/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend", "//../../maps/generic.png", "/tmp/bam_test/local_store/test_project/mysession/shots/01/../../maps/generic.png", "OK"], ["/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend", "//maps/special.png", "/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.png", "OK"]] stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'commit shot_01' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/maps'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/shots'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'commit shot_01', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:23] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22commit+shot_01%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22commit+shot_01%22%7D&command=commit HTTP/1.1" 200 555 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/mysession/maps/generic.png' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/shots/01/shot_01.blend' packing (A): '/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.png' Adding tmp/bam_test/remote_store/svn_checkout/maps Adding (bin) tmp/bam_test/remote_store/svn_checkout/maps/generic.png Adding tmp/bam_test/remote_store/svn_checkout/shots Adding tmp/bam_test/remote_store/svn_checkout/shots/01 Adding tmp/bam_test/remote_store/svn_checkout/shots/01/maps Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.png Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend Transmitting file data ... Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout shots/01/shot_01.blend --output new_out INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:23] "GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' INFO:webservice: Zip path: '/tmp/tmpn3o4oaoo.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' archiving: 3 files copying: b'/tmp/__blendfile_temp__/shot_01.blend@' -> <archive> copying: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/../../maps/generic.png' -> <archive> copying: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.png' -> <archive> written: b'/tmp/tmpn3o4oaoo.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/new_out' stderr: Exists? /tmp/bam_test/local_store/test_project/new_out/maps/special.png Exists? /tmp/bam_test/local_store/test_project/new_out/_maps/generic.png .>>> svnadmin create test_project stdout: b'' stderr: b'' return: 0 >>> svn checkout file:///tmp/bam_test/remote_store/svn_repo/test_project /tmp/bam_test/remote_store/svn_checkout stdout: b'Checked out revision 0.' stderr: b'' return: 0 >>> svn add /tmp/bam_test/remote_store/svn_checkout/test_project stdout: b'A /tmp/bam_test/remote_store/svn_checkout/test_project\nA /tmp/bam_test/remote_store/svn_checkout/test_project/file1' stderr: b'' return: 0 >>> svn commit -m 'First commit' stdout: b'Adding .\nAdding file1\nTransmitting file data .\nCommitted revision 1.' stderr: b'' return: 0 running: cd '/tmp/bam_test/local_store' ; bam init user@http://localhost:5555/test_project stdout: Project 'test_project' initialized stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam create mysession stdout: Session 'mysession' created stderr: >>> blender --background --factory-startup -noaudio --python ./tests/blendfile_templates.py -- /tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend /tmp/bam_test/local_store/test_project/mysession /tmp/bam_test/blend_template_deps.json create_from_file_liblinks /tmp/bam_test/blendfile_create_data.json 123 stdout: b"Info: Read library: '/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend', '//../../../maps/generic.blend'\n[['/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend', 'Scene10', ['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']], ['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend', 'MySpecial', ['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend']], ['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend', 'MyGeneric', []]]\n['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']\n['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend']\n[]\n['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']\n['/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend']\n['/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend']\nError: Not freed memory blocks: 215" stderr: b'' return: 123 running: cd '/tmp/bam_test/local_store/test_project' ; bam deps /tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend --json INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None stdout: [ ["/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend", "//maps/special.blend", "/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend", "OK"]] stderr: running: cd '/tmp/bam_test/local_store/test_project/mysession' ; bam commit -m 'commit shot_01' INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None DEBUG:bam_cli:{} INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'status', '/tmp/bam_test/remote_store/svn_checkout', '--xml'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/maps'] DEBUG:svn:RUN: ['svn', 'add', '/tmp/bam_test/remote_store/svn_checkout/shots'] DEBUG:webservice:{} DEBUG:svn:RUN: ['svn', 'info', '--xml', '/tmp/bam_test/remote_store/svn_checkout'] DEBUG:svn:RUN: ['svn', 'commit', '/tmp/bam_test/remote_store/svn_checkout', '--no-auth-cache', '--message', 'commit shot_01', '--username', 'user', '--password', 'my_password'] INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:24] "PUT /test_project/file?arguments=%7B%22message%22%3A+%22commit+shot_01%22%7D&command=commit HTTP/1.1" 200 - DEBUG:requests.packages.urllib3.connectionpool:"PUT /test_project/file?arguments=%7B%22message%22%3A+%22commit+shot_01%22%7D&command=commit HTTP/1.1" 200 800 stdout: Now make a zipfile packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/maps/generic.blend' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/shots/01/shot_01.blend' packing (A): '/tmp/bam_test/local_store/test_project/mysession/shots/01/maps/special.blend1' packing (A): '/tmp/bam_test/local_store/test_project/mysession/shots/01/shot_01.blend1' packing (A): '/tmp/bam_test/local_store/test_project/.bam/tmp/shots/01/maps/special.blend' packing (A): '/tmp/bam_test/local_store/test_project/mysession/maps/generic.blend1' Adding tmp/bam_test/remote_store/svn_checkout/maps Adding (bin) tmp/bam_test/remote_store/svn_checkout/maps/generic.blend Adding (bin) tmp/bam_test/remote_store/svn_checkout/maps/generic.blend1 Adding tmp/bam_test/remote_store/svn_checkout/shots Adding tmp/bam_test/remote_store/svn_checkout/shots/01 Adding tmp/bam_test/remote_store/svn_checkout/shots/01/maps Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend1 Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend Adding (bin) tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend1 Transmitting file data ...... Committed revision 2. stderr: running: cd '/tmp/bam_test/local_store/test_project' ; bam checkout shots/01/shot_01.blend --output new_out INFO:requests.packages.urllib3.connectionpool:Starting new HTTP connection (1): localhost INFO:werkzeug:127.0.0.1 - - [03/Dec/2014 23:16:24] "GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 - INFO:webservice: Source path: '/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' INFO:webservice: Zip path: '/tmp/tmpt3bzjuba.zip' DEBUG:requests.packages.urllib3.connectionpool:"GET /test_project/file?filepath=shots%2F01%2Fshot_01.blend&command=checkout HTTP/1.1" 200 None INFO:path_walker:~ INFO:path_walker:/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend INFO:path_walker:None DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker:None Library: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend INFO:path_walker: SCMySpecial DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker: SCMySpecial, WOWorld Library: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' -> b'/tmp/bam_test/remote_store/svn_checkout/maps/generic.blend' INFO:path_walker:~ INFO:path_walker: /tmp/bam_test/remote_store/svn_checkout/maps/generic.blend INFO:path_walker: SCMyGeneric DEBUG:blendfile:normal blendfile detected DEBUG:blendfile:initializing reading blend-file DEBUG:blendfile:reading blend-file-header DEBUG:blendfile:building DNA catalog DEBUG:blendfile:building #3932 names DEBUG:blendfile:building #643 types DEBUG:blendfile:building #643 type-lengths DEBUG:blendfile:building #567 structures INFO:path_walker: SCMyGeneric, WOWorld stdout: scanning deps: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend'... blend: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/shot_01.blend' blend: b'/tmp/bam_test/remote_store/svn_checkout/shots/01/maps/special.blend' archiving: 1 files copying: b'/tmp/__blendfile_temp__/shot_01.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/maps/special.blend@' -> <archive> copying: b'/tmp/__blendfile_temp__/_maps/generic.blend@' -> <archive> written: b'/tmp/tmpt3bzjuba.zip' download: [100%] written: '/tmp/bam_test/local_store/test_project/new_out' stderr: Exists? /tmp/bam_test/local_store/test_project/new_out/shot_01.blend Exists? /tmp/bam_test/local_store/test_project/new_out/maps/special.blend Exists? /tmp/bam_test/local_store/test_project/new_out/_maps/generic.blend . ---------------------------------------------------------------------- Ran 15 tests in 13.869s OK