builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1449113722.75 results: success (0) buildid: 20151202192428 builduid: 628ba87d742544d1a45f7109bf5868b0 revision: 10a9cf7c54fadd9073807e863725ee1b32449ba6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.749789) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.750341) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.750756) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.788470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.788779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.816679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.816969) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.868427) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.868717) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.869167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:22.869748) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 19:35:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-12-02 19:35:23 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170738 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.061408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.061717) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018870 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.116295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.116637) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 10a9cf7c54fadd9073807e863725ee1b32449ba6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 10a9cf7c54fadd9073807e863725ee1b32449ba6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 19:35:23,586 truncating revision to first 12 chars 2015-12-02 19:35:23,586 Setting DEBUG logging. 2015-12-02 19:35:23,586 attempt 1/10 2015-12-02 19:35:23,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/10a9cf7c54fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 19:35:23,824 unpacking tar archive at: fx-team-10a9cf7c54fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518055 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.647647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.647951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.654806) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.655111) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 19:35:23.655541) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-02 19:35:23.655857) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:35:24 INFO - MultiFileLogger online at 20151202 19:35:24 in /builds/slave/test 19:35:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:35:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:35:24 INFO - {'append_to_log': False, 19:35:24 INFO - 'base_work_dir': '/builds/slave/test', 19:35:24 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:35:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:35:24 INFO - 'branch': 'Fx-Team-Non-PGO', 19:35:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:35:24 INFO - 'config_files': ('talos/linux_config.py',), 19:35:24 INFO - 'default_actions': ('clobber', 19:35:24 INFO - 'read-buildbot-config', 19:35:24 INFO - 'download-and-extract', 19:35:24 INFO - 'populate-webroot', 19:35:24 INFO - 'create-virtualenv', 19:35:24 INFO - 'install', 19:35:24 INFO - 'run-tests'), 19:35:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:35:24 INFO - 'download_minidump_stackwalk': True, 19:35:24 INFO - 'download_symbols': 'ondemand', 19:35:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:35:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:35:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:35:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:35:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:35:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:35:24 INFO - 'installer_path': 'installer.exe', 19:35:24 INFO - 'log_level': 'info', 19:35:24 INFO - 'log_name': 'talos', 19:35:24 INFO - 'log_to_console': True, 19:35:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:35:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:35:24 INFO - 'opt_config_files': (), 19:35:24 INFO - 'pip_index': False, 19:35:24 INFO - 'sps_profile': False, 19:35:24 INFO - 'sps_profile_interval': 0, 19:35:24 INFO - 'suite': 'dromaeojs', 19:35:24 INFO - 'system_bits': '64', 19:35:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:35:24 INFO - 'title': 'talos-linux64-ix-059', 19:35:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:35:24 INFO - 'use_talos_json': True, 19:35:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:35:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:35:24 INFO - 'work_dir': 'build'} 19:35:24 INFO - ##### 19:35:24 INFO - ##### Running clobber step. 19:35:24 INFO - ##### 19:35:24 INFO - Running pre-action listener: _resource_record_pre_action 19:35:24 INFO - Running main action method: clobber 19:35:24 INFO - rmtree: /builds/slave/test/build 19:35:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:35:25 INFO - Running post-action listener: _resource_record_post_action 19:35:25 INFO - ##### 19:35:25 INFO - ##### Running read-buildbot-config step. 19:35:25 INFO - ##### 19:35:25 INFO - Running pre-action listener: _resource_record_pre_action 19:35:25 INFO - Running main action method: read_buildbot_config 19:35:25 INFO - Using buildbot properties: 19:35:25 INFO - { 19:35:25 INFO - "properties": { 19:35:25 INFO - "buildnumber": 975, 19:35:25 INFO - "product": "firefox", 19:35:25 INFO - "script_repo_revision": "production", 19:35:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:35:25 INFO - "repository": "", 19:35:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:35:25 INFO - "buildid": "20151202192428", 19:35:25 INFO - "slavename": "talos-linux64-ix-059", 19:35:25 INFO - "pgo_build": "False", 19:35:25 INFO - "basedir": "/builds/slave/test", 19:35:25 INFO - "project": "", 19:35:25 INFO - "platform": "ubuntu64_hw", 19:35:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:35:25 INFO - "slavebuilddir": "test", 19:35:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:35:25 INFO - "branch": "fx-team", 19:35:25 INFO - "repo_path": "integration/fx-team", 19:35:25 INFO - "stage_platform": "linux64", 19:35:25 INFO - "builduid": "628ba87d742544d1a45f7109bf5868b0", 19:35:25 INFO - "revision": "10a9cf7c54fadd9073807e863725ee1b32449ba6" 19:35:25 INFO - }, 19:35:25 INFO - "sourcestamp": { 19:35:25 INFO - "repository": "", 19:35:25 INFO - "hasPatch": false, 19:35:25 INFO - "project": "", 19:35:25 INFO - "branch": "fx-team-linux64-talos", 19:35:25 INFO - "changes": [ 19:35:25 INFO - { 19:35:25 INFO - "category": null, 19:35:25 INFO - "files": [ 19:35:25 INFO - { 19:35:25 INFO - "url": null, 19:35:25 INFO - "name": "https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:35:25 INFO - } 19:35:25 INFO - ], 19:35:25 INFO - "repository": "", 19:35:25 INFO - "rev": "10a9cf7c54fadd9073807e863725ee1b32449ba6", 19:35:25 INFO - "who": "jwein@mozilla.com", 19:35:25 INFO - "when": 1449113659, 19:35:25 INFO - "number": 6737302, 19:35:25 INFO - "comments": "Bug 1227711 - Add a box-shadow to the XUL alerts. ui-r=shorlander r=MattN", 19:35:25 INFO - "project": "", 19:35:25 INFO - "at": "Wed 02 Dec 2015 19:34:19", 19:35:25 INFO - "branch": "fx-team-linux64-talos", 19:35:25 INFO - "revlink": "", 19:35:25 INFO - "properties": [ 19:35:25 INFO - [ 19:35:25 INFO - "buildid", 19:35:25 INFO - "20151202192428", 19:35:25 INFO - "Change" 19:35:25 INFO - ], 19:35:25 INFO - [ 19:35:25 INFO - "builduid", 19:35:25 INFO - "628ba87d742544d1a45f7109bf5868b0", 19:35:25 INFO - "Change" 19:35:25 INFO - ], 19:35:25 INFO - [ 19:35:25 INFO - "pgo_build", 19:35:25 INFO - "False", 19:35:25 INFO - "Change" 19:35:25 INFO - ] 19:35:25 INFO - ], 19:35:25 INFO - "revision": "10a9cf7c54fadd9073807e863725ee1b32449ba6" 19:35:25 INFO - } 19:35:25 INFO - ], 19:35:25 INFO - "revision": "10a9cf7c54fadd9073807e863725ee1b32449ba6" 19:35:25 INFO - } 19:35:25 INFO - } 19:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:35:25 INFO - Running post-action listener: _resource_record_post_action 19:35:25 INFO - ##### 19:35:25 INFO - ##### Running download-and-extract step. 19:35:25 INFO - ##### 19:35:25 INFO - Running pre-action listener: _resource_record_pre_action 19:35:25 INFO - Running main action method: download_and_extract 19:35:25 INFO - mkdir: /builds/slave/test/build/tests 19:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:25 INFO - https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/test_packages.json 19:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/test_packages.json 19:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:35:30 INFO - Downloaded 1302 bytes. 19:35:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:35:30 INFO - Using the following test package requirements: 19:35:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:35:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:35:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:30 INFO - u'jsshell-linux-x86_64.zip'], 19:35:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:35:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:35:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:35:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:35:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:35:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:35:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:35:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:30 INFO - https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:35:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:35:37 INFO - Downloaded 21775337 bytes. 19:35:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:35:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:35:38 INFO - Return code: 0 19:35:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:38 INFO - https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:35:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:35:43 INFO - Downloaded 21775337 bytes. 19:35:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:35:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:35:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:35:44 INFO - Return code: 0 19:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:44 INFO - https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:35:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:35:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:35:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:35:45 INFO - Downloaded 11132001 bytes. 19:35:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 19:35:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:35:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:35:46 INFO - Return code: 0 19:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:46 INFO - https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:35:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:35:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:35:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:35:47 INFO - Downloaded 57677709 bytes. 19:35:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:35:47 INFO - mkdir: /builds/slave/test/properties 19:35:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:35:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:35:47 INFO - Contents: 19:35:47 INFO - build_url:https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:35:47 INFO - Running post-action listener: _resource_record_post_action 19:35:47 INFO - Running post-action listener: set_extra_try_arguments 19:35:47 INFO - ##### 19:35:47 INFO - ##### Running populate-webroot step. 19:35:47 INFO - ##### 19:35:47 INFO - Running pre-action listener: _resource_record_pre_action 19:35:47 INFO - Running main action method: populate_webroot 19:35:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:35:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:35:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:35:47 INFO - '../fennec_ids.txt'], 19:35:47 INFO - 'tests': ['tcheck2']}, 19:35:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:35:47 INFO - '--tppagecycles', 19:35:47 INFO - '7'], 19:35:47 INFO - 'tests': ['tsvgm']}}, 19:35:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:35:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:35:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:35:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:35:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'tests': ['damp', 'tps']}, 19:35:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['damp', 'tps']}, 19:35:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:35:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:35:47 INFO - 'other': {'tests': ['a11yr', 19:35:47 INFO - 'ts_paint', 19:35:47 INFO - 'tpaint', 19:35:47 INFO - 'sessionrestore', 19:35:47 INFO - 'sessionrestore_no_auto_restore']}, 19:35:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['a11yr', 19:35:47 INFO - 'ts_paint', 19:35:47 INFO - 'tpaint', 19:35:47 INFO - 'sessionrestore', 19:35:47 INFO - 'sessionrestore_no_auto_restore']}, 19:35:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['a11yr', 19:35:47 INFO - 'ts_paint', 19:35:47 INFO - 'tpaint', 19:35:47 INFO - 'sessionrestore', 19:35:47 INFO - 'sessionrestore_no_auto_restore']}, 19:35:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['a11yr', 19:35:47 INFO - 'ts_paint', 19:35:47 INFO - 'tpaint', 19:35:47 INFO - 'sessionrestore', 19:35:47 INFO - 'sessionrestore_no_auto_restore']}, 19:35:47 INFO - 'other_l64': {'tests': ['a11yr', 19:35:47 INFO - 'ts_paint', 19:35:47 INFO - 'tpaint', 19:35:47 INFO - 'sessionrestore', 19:35:47 INFO - 'sessionrestore_no_auto_restore']}, 19:35:47 INFO - 'other_nol64': {'tests': ['a11yr', 19:35:47 INFO - 'ts_paint', 19:35:47 INFO - 'tpaint', 19:35:47 INFO - 'sessionrestore', 19:35:47 INFO - 'sessionrestore_no_auto_restore']}, 19:35:47 INFO - 'svgr': {'tests': ['tsvgx', 19:35:47 INFO - 'tsvgr_opacity', 19:35:47 INFO - 'tart', 19:35:47 INFO - 'tscrollx', 19:35:47 INFO - 'cart']}, 19:35:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['tsvgx', 19:35:47 INFO - 'tsvgr_opacity', 19:35:47 INFO - 'tart', 19:35:47 INFO - 'tscrollx', 19:35:47 INFO - 'cart']}, 19:35:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'tests': ['tp5o']}, 19:35:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'talos_options': ['--e10s'], 19:35:47 INFO - 'tests': ['tp5o']}, 19:35:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'talos_options': ['--xperf_path', 19:35:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:47 INFO - 'tests': ['tp5n']}, 19:35:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:47 INFO - 'talos_options': ['--e10s', 19:35:47 INFO - '--xperf_path', 19:35:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:47 INFO - 'tests': ['tp5n']}}, 19:35:47 INFO - 'talos.zip': {'path': '', 19:35:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:35:47 INFO - Running post-action listener: _resource_record_post_action 19:35:47 INFO - ##### 19:35:47 INFO - ##### Running create-virtualenv step. 19:35:47 INFO - ##### 19:35:47 INFO - Running pre-action listener: _resource_record_pre_action 19:35:47 INFO - Running main action method: create_virtualenv 19:35:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:35:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:35:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:35:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:35:47 INFO - Using real prefix '/usr' 19:35:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:35:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:35:50 INFO - Installing pip.................done. 19:35:50 INFO - Return code: 0 19:35:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:35:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:35:50 INFO - Using env: {'DISPLAY': ':0', 19:35:50 INFO - 'HOME': '/home/cltbld', 19:35:50 INFO - 'LANG': 'en_US.UTF-8', 19:35:50 INFO - 'LANGUAGE': 'en_US:en', 19:35:50 INFO - 'LOGNAME': 'cltbld', 19:35:50 INFO - 'MAIL': '/var/mail/cltbld', 19:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:50 INFO - 'MOZ_NO_REMOTE': '1', 19:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:35:50 INFO - 'NO_EM_RESTART': '1', 19:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:50 INFO - 'PWD': '/builds/slave/test', 19:35:50 INFO - 'SHELL': '/bin/bash', 19:35:50 INFO - 'SHLVL': '1', 19:35:50 INFO - 'TERM': 'linux', 19:35:50 INFO - 'TMOUT': '86400', 19:35:50 INFO - 'USER': 'cltbld', 19:35:50 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:50 INFO - '_': '/tools/buildbot/bin/python'} 19:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:35:50 INFO - Cleaning up... 19:35:50 INFO - Return code: 0 19:35:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:35:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:35:50 INFO - Using env: {'DISPLAY': ':0', 19:35:50 INFO - 'HOME': '/home/cltbld', 19:35:50 INFO - 'LANG': 'en_US.UTF-8', 19:35:50 INFO - 'LANGUAGE': 'en_US:en', 19:35:50 INFO - 'LOGNAME': 'cltbld', 19:35:50 INFO - 'MAIL': '/var/mail/cltbld', 19:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:50 INFO - 'MOZ_NO_REMOTE': '1', 19:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:35:50 INFO - 'NO_EM_RESTART': '1', 19:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:50 INFO - 'PWD': '/builds/slave/test', 19:35:50 INFO - 'SHELL': '/bin/bash', 19:35:50 INFO - 'SHLVL': '1', 19:35:50 INFO - 'TERM': 'linux', 19:35:50 INFO - 'TMOUT': '86400', 19:35:50 INFO - 'USER': 'cltbld', 19:35:50 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:50 INFO - '_': '/tools/buildbot/bin/python'} 19:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:50 INFO - Downloading/unpacking psutil>=0.7.1 19:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:35:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:35:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:35:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:35:52 INFO - Installing collected packages: psutil 19:35:52 INFO - Running setup.py install for psutil 19:35:52 INFO - building 'psutil._psutil_linux' extension 19:35:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:35:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:35:52 INFO - building 'psutil._psutil_posix' extension 19:35:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:35:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:35:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:35:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:35:52 INFO - Successfully installed psutil 19:35:52 INFO - Cleaning up... 19:35:52 INFO - Return code: 0 19:35:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:35:52 INFO - Using env: {'DISPLAY': ':0', 19:35:52 INFO - 'HOME': '/home/cltbld', 19:35:52 INFO - 'LANG': 'en_US.UTF-8', 19:35:52 INFO - 'LANGUAGE': 'en_US:en', 19:35:52 INFO - 'LOGNAME': 'cltbld', 19:35:52 INFO - 'MAIL': '/var/mail/cltbld', 19:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:52 INFO - 'MOZ_NO_REMOTE': '1', 19:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:35:52 INFO - 'NO_EM_RESTART': '1', 19:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:52 INFO - 'PWD': '/builds/slave/test', 19:35:52 INFO - 'SHELL': '/bin/bash', 19:35:52 INFO - 'SHLVL': '1', 19:35:52 INFO - 'TERM': 'linux', 19:35:52 INFO - 'TMOUT': '86400', 19:35:52 INFO - 'USER': 'cltbld', 19:35:52 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:52 INFO - '_': '/tools/buildbot/bin/python'} 19:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:35:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:35:54 INFO - Installing collected packages: mozsystemmonitor 19:35:54 INFO - Running setup.py install for mozsystemmonitor 19:35:54 INFO - Successfully installed mozsystemmonitor 19:35:54 INFO - Cleaning up... 19:35:54 INFO - Return code: 0 19:35:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:35:54 INFO - Using env: {'DISPLAY': ':0', 19:35:54 INFO - 'HOME': '/home/cltbld', 19:35:54 INFO - 'LANG': 'en_US.UTF-8', 19:35:54 INFO - 'LANGUAGE': 'en_US:en', 19:35:54 INFO - 'LOGNAME': 'cltbld', 19:35:54 INFO - 'MAIL': '/var/mail/cltbld', 19:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:54 INFO - 'MOZ_NO_REMOTE': '1', 19:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:35:54 INFO - 'NO_EM_RESTART': '1', 19:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:54 INFO - 'PWD': '/builds/slave/test', 19:35:54 INFO - 'SHELL': '/bin/bash', 19:35:54 INFO - 'SHLVL': '1', 19:35:54 INFO - 'TERM': 'linux', 19:35:54 INFO - 'TMOUT': '86400', 19:35:54 INFO - 'USER': 'cltbld', 19:35:54 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:54 INFO - '_': '/tools/buildbot/bin/python'} 19:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:55 INFO - Downloading/unpacking blobuploader==1.2.4 19:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:56 INFO - Downloading blobuploader-1.2.4.tar.gz 19:35:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:35:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:35:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:57 INFO - Downloading docopt-0.6.1.tar.gz 19:35:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:35:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:35:57 INFO - Running setup.py install for blobuploader 19:35:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:35:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:35:57 INFO - Running setup.py install for requests 19:35:57 INFO - Running setup.py install for docopt 19:35:58 INFO - Successfully installed blobuploader requests docopt 19:35:58 INFO - Cleaning up... 19:35:58 INFO - Return code: 0 19:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:35:58 INFO - Using env: {'DISPLAY': ':0', 19:35:58 INFO - 'HOME': '/home/cltbld', 19:35:58 INFO - 'LANG': 'en_US.UTF-8', 19:35:58 INFO - 'LANGUAGE': 'en_US:en', 19:35:58 INFO - 'LOGNAME': 'cltbld', 19:35:58 INFO - 'MAIL': '/var/mail/cltbld', 19:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:58 INFO - 'MOZ_NO_REMOTE': '1', 19:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:35:58 INFO - 'NO_EM_RESTART': '1', 19:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:58 INFO - 'PWD': '/builds/slave/test', 19:35:58 INFO - 'SHELL': '/bin/bash', 19:35:58 INFO - 'SHLVL': '1', 19:35:58 INFO - 'TERM': 'linux', 19:35:58 INFO - 'TMOUT': '86400', 19:35:58 INFO - 'USER': 'cltbld', 19:35:58 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:58 INFO - '_': '/tools/buildbot/bin/python'} 19:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:35:58 INFO - Running setup.py (path:/tmp/pip-fSZ3mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:35:58 INFO - Running setup.py (path:/tmp/pip-OD65mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:35:58 INFO - Running setup.py (path:/tmp/pip-Ki1SaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:35:58 INFO - Running setup.py (path:/tmp/pip-Zb_P1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:35:58 INFO - Running setup.py (path:/tmp/pip-qvgvix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:35:58 INFO - Running setup.py (path:/tmp/pip-8VpmzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:35:58 INFO - Running setup.py (path:/tmp/pip-k8XCyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:35:58 INFO - Running setup.py (path:/tmp/pip-3ETkxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:35:58 INFO - Running setup.py (path:/tmp/pip-FWbXyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:35:59 INFO - Running setup.py (path:/tmp/pip-_ZbE_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:35:59 INFO - Running setup.py (path:/tmp/pip-Oum3_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:35:59 INFO - Running setup.py (path:/tmp/pip-s71s1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:35:59 INFO - Running setup.py (path:/tmp/pip-40beOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:35:59 INFO - Running setup.py (path:/tmp/pip-uLARXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:59 INFO - Running setup.py (path:/tmp/pip-lHTPX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:35:59 INFO - Running setup.py (path:/tmp/pip-lqED0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:35:59 INFO - Running setup.py (path:/tmp/pip-nACoK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:35:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:35:59 INFO - Running setup.py install for manifestparser 19:35:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:35:59 INFO - Running setup.py install for mozcrash 19:35:59 INFO - Running setup.py install for mozdebug 19:35:59 INFO - Running setup.py install for mozdevice 19:35:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:35:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Running setup.py install for mozfile 19:36:00 INFO - Running setup.py install for mozhttpd 19:36:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Running setup.py install for mozinfo 19:36:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Running setup.py install for mozInstall 19:36:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Running setup.py install for mozleak 19:36:00 INFO - Running setup.py install for mozlog 19:36:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Running setup.py install for moznetwork 19:36:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Running setup.py install for mozprocess 19:36:00 INFO - Running setup.py install for mozprofile 19:36:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:00 INFO - Running setup.py install for mozrunner 19:36:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:01 INFO - Running setup.py install for mozscreenshot 19:36:01 INFO - Running setup.py install for moztest 19:36:01 INFO - Running setup.py install for mozversion 19:36:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:01 INFO - Cleaning up... 19:36:01 INFO - Return code: 0 19:36:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:01 INFO - Using env: {'DISPLAY': ':0', 19:36:01 INFO - 'HOME': '/home/cltbld', 19:36:01 INFO - 'LANG': 'en_US.UTF-8', 19:36:01 INFO - 'LANGUAGE': 'en_US:en', 19:36:01 INFO - 'LOGNAME': 'cltbld', 19:36:01 INFO - 'MAIL': '/var/mail/cltbld', 19:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:01 INFO - 'MOZ_NO_REMOTE': '1', 19:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:01 INFO - 'NO_EM_RESTART': '1', 19:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:01 INFO - 'PWD': '/builds/slave/test', 19:36:01 INFO - 'SHELL': '/bin/bash', 19:36:01 INFO - 'SHLVL': '1', 19:36:01 INFO - 'TERM': 'linux', 19:36:01 INFO - 'TMOUT': '86400', 19:36:01 INFO - 'USER': 'cltbld', 19:36:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:01 INFO - '_': '/tools/buildbot/bin/python'} 19:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:01 INFO - Running setup.py (path:/tmp/pip-iiRM2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:01 INFO - Running setup.py (path:/tmp/pip-xSINp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:01 INFO - Running setup.py (path:/tmp/pip-C_zaVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:01 INFO - Running setup.py (path:/tmp/pip-LiCn5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:01 INFO - Running setup.py (path:/tmp/pip-6TjUgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:01 INFO - Running setup.py (path:/tmp/pip-ngI5QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:02 INFO - Running setup.py (path:/tmp/pip-MHmaVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:02 INFO - Running setup.py (path:/tmp/pip-OxC2fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:02 INFO - Running setup.py (path:/tmp/pip-97oEV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:02 INFO - Running setup.py (path:/tmp/pip-Gfmyt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:02 INFO - Running setup.py (path:/tmp/pip-TXujeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:02 INFO - Running setup.py (path:/tmp/pip-XQBzvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:02 INFO - Running setup.py (path:/tmp/pip-zK6oNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:02 INFO - Running setup.py (path:/tmp/pip-aj4Uxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:02 INFO - Running setup.py (path:/tmp/pip-PzHUd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:02 INFO - Running setup.py (path:/tmp/pip-OuRTjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:02 INFO - Running setup.py (path:/tmp/pip-KAmidP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:04 INFO - Downloading blessings-1.5.1.tar.gz 19:36:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:04 INFO - Installing collected packages: blessings 19:36:04 INFO - Running setup.py install for blessings 19:36:04 INFO - Successfully installed blessings 19:36:04 INFO - Cleaning up... 19:36:04 INFO - Return code: 0 19:36:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:04 INFO - Reading from file tmpfile_stdout 19:36:04 INFO - Current package versions: 19:36:04 INFO - argparse == 1.2.1 19:36:04 INFO - blessings == 1.5.1 19:36:04 INFO - blobuploader == 1.2.4 19:36:04 INFO - docopt == 0.6.1 19:36:04 INFO - manifestparser == 1.1 19:36:04 INFO - mozInstall == 1.12 19:36:04 INFO - mozcrash == 0.16 19:36:04 INFO - mozdebug == 0.1 19:36:04 INFO - mozdevice == 0.47 19:36:04 INFO - mozfile == 1.2 19:36:04 INFO - mozhttpd == 0.7 19:36:04 INFO - mozinfo == 0.9 19:36:04 INFO - mozleak == 0.1 19:36:04 INFO - mozlog == 3.1 19:36:04 INFO - moznetwork == 0.27 19:36:04 INFO - mozprocess == 0.22 19:36:04 INFO - mozprofile == 0.27 19:36:04 INFO - mozrunner == 6.11 19:36:04 INFO - mozscreenshot == 0.1 19:36:04 INFO - mozsystemmonitor == 0.0 19:36:04 INFO - moztest == 0.7 19:36:04 INFO - mozversion == 1.4 19:36:04 INFO - psutil == 3.1.1 19:36:04 INFO - requests == 1.2.3 19:36:04 INFO - wsgiref == 0.1.2 19:36:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:04 INFO - Using env: {'DISPLAY': ':0', 19:36:04 INFO - 'HOME': '/home/cltbld', 19:36:04 INFO - 'LANG': 'en_US.UTF-8', 19:36:04 INFO - 'LANGUAGE': 'en_US:en', 19:36:04 INFO - 'LOGNAME': 'cltbld', 19:36:04 INFO - 'MAIL': '/var/mail/cltbld', 19:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:04 INFO - 'MOZ_NO_REMOTE': '1', 19:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:04 INFO - 'NO_EM_RESTART': '1', 19:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:04 INFO - 'PWD': '/builds/slave/test', 19:36:04 INFO - 'SHELL': '/bin/bash', 19:36:04 INFO - 'SHLVL': '1', 19:36:04 INFO - 'TERM': 'linux', 19:36:04 INFO - 'TMOUT': '86400', 19:36:04 INFO - 'USER': 'cltbld', 19:36:04 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:04 INFO - '_': '/tools/buildbot/bin/python'} 19:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:36:05 INFO - Cleaning up... 19:36:05 INFO - Return code: 0 19:36:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:36:05 INFO - Using env: {'DISPLAY': ':0', 19:36:05 INFO - 'HOME': '/home/cltbld', 19:36:05 INFO - 'LANG': 'en_US.UTF-8', 19:36:05 INFO - 'LANGUAGE': 'en_US:en', 19:36:05 INFO - 'LOGNAME': 'cltbld', 19:36:05 INFO - 'MAIL': '/var/mail/cltbld', 19:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:05 INFO - 'MOZ_NO_REMOTE': '1', 19:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:05 INFO - 'NO_EM_RESTART': '1', 19:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:05 INFO - 'PWD': '/builds/slave/test', 19:36:05 INFO - 'SHELL': '/bin/bash', 19:36:05 INFO - 'SHLVL': '1', 19:36:05 INFO - 'TERM': 'linux', 19:36:05 INFO - 'TMOUT': '86400', 19:36:05 INFO - 'USER': 'cltbld', 19:36:05 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:05 INFO - '_': '/tools/buildbot/bin/python'} 19:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:05 INFO - Downloading/unpacking jsonschema 19:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:36:07 INFO - Downloading/unpacking functools32 (from jsonschema) 19:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:07 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:07 INFO - warning: no files found matching '*.txt' 19:36:07 INFO - no previously-included directories found matching 'build' 19:36:07 INFO - no previously-included directories found matching 'dist' 19:36:07 INFO - no previously-included directories found matching '.git*' 19:36:07 INFO - Installing collected packages: jsonschema, functools32 19:36:07 INFO - Running setup.py install for functools32 19:36:07 INFO - warning: no files found matching '*.txt' 19:36:07 INFO - no previously-included directories found matching 'build' 19:36:07 INFO - no previously-included directories found matching 'dist' 19:36:07 INFO - no previously-included directories found matching '.git*' 19:36:07 INFO - Successfully installed jsonschema functools32 19:36:07 INFO - Cleaning up... 19:36:07 INFO - Return code: 0 19:36:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f53d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x147f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:36:07 INFO - Using env: {'DISPLAY': ':0', 19:36:07 INFO - 'HOME': '/home/cltbld', 19:36:07 INFO - 'LANG': 'en_US.UTF-8', 19:36:07 INFO - 'LANGUAGE': 'en_US:en', 19:36:07 INFO - 'LOGNAME': 'cltbld', 19:36:07 INFO - 'MAIL': '/var/mail/cltbld', 19:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:07 INFO - 'MOZ_NO_REMOTE': '1', 19:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:07 INFO - 'NO_EM_RESTART': '1', 19:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:07 INFO - 'PWD': '/builds/slave/test', 19:36:07 INFO - 'SHELL': '/bin/bash', 19:36:07 INFO - 'SHLVL': '1', 19:36:07 INFO - 'TERM': 'linux', 19:36:07 INFO - 'TMOUT': '86400', 19:36:07 INFO - 'USER': 'cltbld', 19:36:07 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:07 INFO - '_': '/tools/buildbot/bin/python'} 19:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:07 INFO - Downloading/unpacking flake8 19:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:36:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:36:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:36:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:36:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:36:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:10 INFO - no previously-included directories found matching 'docs/_build' 19:36:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:36:10 INFO - Running setup.py install for pep8 19:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:10 INFO - no previously-included directories found matching 'docs/_build' 19:36:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:36:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:36:10 INFO - Cleaning up... 19:36:10 INFO - Return code: 0 19:36:10 INFO - Running post-action listener: _resource_record_post_action 19:36:10 INFO - Running post-action listener: _start_resource_monitoring 19:36:10 INFO - Starting resource monitoring. 19:36:10 INFO - ##### 19:36:10 INFO - ##### Running install step. 19:36:10 INFO - ##### 19:36:10 INFO - Running pre-action listener: _resource_record_pre_action 19:36:10 INFO - Running main action method: install 19:36:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:10 INFO - Reading from file tmpfile_stdout 19:36:10 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:10 INFO - Reading from file tmpfile_stdout 19:36:10 INFO - Output received: 19:36:10 INFO - Usage: mozinstall [options] installer 19:36:10 INFO - Options: 19:36:10 INFO - -h, --help show this help message and exit 19:36:10 INFO - -d DEST, --destination=DEST 19:36:10 INFO - Directory to install application into. [default: 19:36:10 INFO - "/builds/slave/test"] 19:36:10 INFO - --app=APP Application being installed. [default: firefox] 19:36:10 INFO - mkdir: /builds/slave/test/build/application 19:36:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:36:25 INFO - Reading from file tmpfile_stdout 19:36:25 INFO - Output received: 19:36:25 INFO - /builds/slave/test/build/application/firefox/firefox 19:36:25 INFO - Running post-action listener: _resource_record_post_action 19:36:25 INFO - ##### 19:36:25 INFO - ##### Running run-tests step. 19:36:25 INFO - ##### 19:36:25 INFO - Running pre-action listener: _resource_record_pre_action 19:36:25 INFO - Running main action method: run_tests 19:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:36:25 INFO - Python 2.7.3 19:36:25 INFO - Return code: 0 19:36:25 INFO - grabbing minidump binary from tooltool 19:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:36:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:36:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:36:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:36:25 INFO - Return code: 0 19:36:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:36:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:36:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:36:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:36:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:36:26 INFO - Return code: 0 19:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test/build 19:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 19:36:26 INFO - Using env: {'DISPLAY': ':0', 19:36:26 INFO - 'HOME': '/home/cltbld', 19:36:26 INFO - 'LANG': 'en_US.UTF-8', 19:36:26 INFO - 'LANGUAGE': 'en_US:en', 19:36:26 INFO - 'LOGNAME': 'cltbld', 19:36:26 INFO - 'MAIL': '/var/mail/cltbld', 19:36:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:36:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:26 INFO - 'MOZ_NO_REMOTE': '1', 19:36:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:26 INFO - 'NO_EM_RESTART': '1', 19:36:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:26 INFO - 'PWD': '/builds/slave/test', 19:36:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:36:26 INFO - 'SHELL': '/bin/bash', 19:36:26 INFO - 'SHLVL': '1', 19:36:26 INFO - 'TERM': 'linux', 19:36:26 INFO - 'TMOUT': '86400', 19:36:26 INFO - 'USER': 'cltbld', 19:36:26 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810', 19:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:26 INFO - '_': '/tools/buildbot/bin/python'} 19:36:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 19:36:26 INFO - mozversion INFO | application_buildid: 20151202192428 19:36:26 INFO - mozversion INFO | application_changeset: 10a9cf7c54fadd9073807e863725ee1b32449ba6 19:36:26 INFO - mozversion INFO | application_display_name: Nightly 19:36:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:36:26 INFO - mozversion INFO | application_name: Firefox 19:36:26 INFO - mozversion INFO | application_remotingname: firefox 19:36:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:36:26 INFO - mozversion INFO | application_vendor: Mozilla 19:36:26 INFO - mozversion INFO | application_version: 45.0a1 19:36:26 INFO - mozversion INFO | platform_buildid: 20151202192428 19:36:26 INFO - mozversion INFO | platform_changeset: 10a9cf7c54fadd9073807e863725ee1b32449ba6 19:36:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:36:26 INFO - mozversion INFO | platform_version: 45.0a1 19:36:26 INFO - 2015-12-02 19:36:26,377 DEBUG : using testdate: 1449113786 19:36:26 INFO - 2015-12-02 19:36:26,377 DEBUG : actual date: 1449113786 19:36:26 INFO - 2015-12-02 19:36:26,386 INFO : starting webserver on 'localhost:54184' 19:36:26 INFO - 2015-12-02 19:36:26,387 INFO : Starting test suite talos-linux64-ix-059 19:36:26 INFO - 2015-12-02 19:36:26,387 INFO : Starting test dromaeo_css 19:36:26 INFO - 2015-12-02 19:36:26,387 DEBUG : operating with platform_type : linux_ 19:36:26 INFO - 2015-12-02 19:36:26,388 INFO : Initialising browser for dromaeo_css test... 19:36:26 INFO - 2015-12-02 19:36:26,400 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_rG_Qr/profile http://localhost:54184/getInfo.html 19:36:30 INFO - 2015-12-02 19:36:30,577 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:36:30 INFO - 2015-12-02 19:36:30,577 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:36:30 INFO - 2015-12-02 19:36:30,577 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:36:30 INFO - 2015-12-02 19:36:30,577 DEBUG : BROWSER_OUTPUT: __metrics 19:36:30 INFO - 2015-12-02 19:36:30,734 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:36:30 INFO - 2015-12-02 19:36:30,734 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:36:31 INFO - 2015-12-02 19:36:31,869 INFO : Browser initialized. 19:36:31 INFO - 2015-12-02 19:36:31,870 INFO : Running cycle 1/1 for dromaeo_css test... 19:36:31 INFO - 2015-12-02 19:36:31,870 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_rG_Qr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:36:43 INFO - 2015-12-02 19:36:43,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 143122432 19:36:43 INFO - 2015-12-02 19:36:43,901 DEBUG : BROWSER_OUTPUT: 19:37:34 INFO - 2015-12-02 19:37:34,969 DEBUG : BROWSER_OUTPUT: 1449113854965 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:39:46 INFO - 2015-12-02 19:39:46,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54184/tests/dromaeo/cssquery-ext.html) 19:39:47 INFO - 2015-12-02 19:39:47,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 225054720 19:39:47 INFO - 2015-12-02 19:39:47,942 DEBUG : BROWSER_OUTPUT: 19:42:50 INFO - 2015-12-02 19:42:50,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/dromaeo/cssquery-ext.html (next: http://localhost:54184/tests/dromaeo/cssquery-jquery.html) 19:42:50 INFO - 2015-12-02 19:42:50,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 225423360 19:42:50 INFO - 2015-12-02 19:42:50,971 DEBUG : BROWSER_OUTPUT: 19:45:53 INFO - 2015-12-02 19:45:53,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54184/tests/dromaeo/cssquery-mootools.html) 19:45:53 INFO - 2015-12-02 19:45:53,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 216698880 19:45:53 INFO - 2015-12-02 19:45:53,616 DEBUG : BROWSER_OUTPUT: 19:48:55 INFO - 2015-12-02 19:48:55,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54184/tests/dromaeo/cssquery-prototype.html) 19:48:56 INFO - 2015-12-02 19:48:56,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 201928704 19:48:56 INFO - 2015-12-02 19:48:56,160 DEBUG : BROWSER_OUTPUT: 19:51:58 INFO - 2015-12-02 19:51:58,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54184/tests/dromaeo/cssquery-yui.html) 19:51:59 INFO - 2015-12-02 19:51:59,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 208625664 19:51:59 INFO - 2015-12-02 19:51:59,569 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/dromaeo/cssquery-yui.html (next: http://localhost:54184/tests/dromaeo/cssquery-dojo.html) 19:55:02 INFO - 2015-12-02 19:55:02,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 252153856 19:55:02 INFO - 2015-12-02 19:55:02,490 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,491 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:55:02 INFO - 2015-12-02 19:55:02,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:55:02 INFO - 2015-12-02 19:55:02,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:55:02 INFO - 2015-12-02 19:55:02,491 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:55:02 INFO - 2015-12-02 19:55:02,491 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2607.973920260797;2616.712161662218;2617.2279177642604;2631.3290111021697;2638.6305917171594;4563.133004729108;4609.79255933483;4612.8385506507275;4626.329182268569;4684.836030738925;4609.308603709437;4642.2804465307845;4677.625789936806;4713.198756211444;4746.359241502396;4095.9590404095875;4334.0681753423005;4342.5657434256555;4374.693771436001;4403.119376124771;4402.185595664796;4420.602145806877;4436.711613745112;4445.0443154721725;4476.888077798065;4154.293770059112;4252.128313695716;4252.851150209759;4269.5516970718245;4395.560443955611;4291.7854107294825;4295;4299.78501074945;4327.6105150536605;4330.978345108286;4273.423087883127;4274.658027357804;4277.187334406484;4327.1345730853955;4329.610335069859;4443.4445694288215;4562.178807814592;4577.725336479822;4595.862124136282;4701.083288758693;5044.344235249394;5047.823326183566;5069.569086627641;5073.137566613685;5115.053715062725;5091.46539613339;5093.821716239951;5098.4136824265315;5098.464661210556;5106;4529.433820772403;4582.679212455096;4643.419572553431;4645.953540464619;4719.5752382285755;5150.304708864255;5177.456367081402;5178.663386879841;5182.481751824863;5183.611229157828;4953.950460495421;4955.281484184845;4956.330895329156;4958.528939750718;4998.400191976913;4864.586510146677;4866.853994380174;4972.8756781080765;4975.228839529878;4986.601071914238;5024.6231532634465;5038;5043.52086551777;5060.7722652480725;5078.21287700407;4971.4282857471135;4974.850754477371;4975.925361119586;4977.452480227172;5018.5985121190215;4033.3143365627916;4145.502539695256;4193.161367726467;4197.370394440797;4236.301010333261;3582.390993531106;3634.491171236029;3657.926841463156;3671.394219953731;3676.540432445944;4378.824847006148;4384.649228061748;4386.605205531518;4395;4421.46942366918;5082;5086.9745651271505;5089.185730283137;5093.159628661229;5129.64092513528;4220.978895105505;4278.764667943231;4317.848875289413;4320.1143765527995;4321.719088259253;4483.955160448354;4495.4605447345875;4502.527234640381;4513.729176249435;4528.977355113269;4828.903421931542;4829.082474330006;4834.613230941586;4838.516148385133;4870.707757534417;4806.519348065165;4895.996320754308;4899.632527560376;5072.416672082758;5081.085404627055;4729.69256998294;4800.591949684316;4835.2505361669;4837.032593481388;4847.442544107332;4959.578435832995;4966.726830024239;4969.105560999054;4972.204447288416;5015.799368025384;4841.515848415131;5036.748162591783;5036.874078148076;5049.343585333883;5049.394072711299;4773;4848.393950756155;4859.3682821233015;4890.364252647133;4892.535209155125;4858.271259311132;4900.705957642553;4904.901901961869;4912.238603016538;4946.826861059845;4669.369635099218;4761.142994261067;4775.092732380836;4782.880427989328;4825.469198388245;4808.807647694053;4848.151573474698;4868.269759535956;4884.462709102067;4937.432195297587;4791.257355109963;4801.975990120027;4806.951930480651;4811.326414302071;4836.564709176191 19:55:02 INFO - 2015-12-02 19:55:02,491 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.8508118033312;557.5261028126091;571.0520535910389;573.3005733005733;573.9684317362544;27450.588241176374;28008.439831203363;28200.871965121423;28225.576616350772;35914.461283080775;39921.201575968465;40290.39564406529;40302.59697403025;40310.59689403105;40443.59556404435;7756.999999999985;7875.779254215606;7923.603819808986;7931.762047138566;7937.126916039231;7131.8217044573785;7338.229485903983;7757.922420775804;9980.550875210633;10275.177985761158;9949;10059.497025148714;10062.647807326744;10066;10067.345622534549;7127.857442851114;9795.363301385423;9919.65281215154;9923.305368624164;9945.055219754111;7028.121484814398;9723.319367644268;9980.401175929395;9994.750131246705;10000.94999525005;33093.69063093695;33449.16377090568;33492;33527.32945341079;33529.161770955674;2823.251838262862;2848.2879280179955;2948.012415840696;3162.478191098489;3355.5302257683943;27646.723532764616;27930.720692793016;28204.43591128166;28253.434931301257;28330.575041374395;3138.3723255349023;3209.149575362531;3227.8708851645906;3254.267789747312;3279.475283954556;207995;208738;208962;210346;210522.99999999846;49749.50250497521;51344;55455.72272138613;55543.722281388335;55573.444265557635;58510.12234816481;59448.70275648594;59642.701786491656;59652.70173649104;59679.64484972107;13500.122492037986;13894.93052534751;13897.444102235999;13907.65230869216;13925.442982280798;10390.116840068678;10482.161427085815;10527.631532896312;10533.052025317758;10536.367817930948;18805.529861753566;19028.71456928147;19075.332363367215;19092.33176838804;19118.522036949187;7358.227386124487;7574.3183113520045;7701.537907725442;7735.574543400055;7745.186755390716;875.6847534887436;910.713125365521;974.3569244298728;988.1620186453191;989.2827699917502;25853.482930341663;25869.23092285247;26050.478990420466;26210.73789262121;26225;955.5652178258875;979.2313034268066;1026.7535791410007;1039.153090231459;1084.8806631270554;13119.606411807661;13132.606021819362;13300.933495332654;13519.797203041962;13528.797068043987;315969;317404.7816652858;319821;320268;322639;44390.77804610956;45011.77494112574;45106.548934510894;45151.54848451539;45210;1211.4427363412929;1226.5216565539447;1238.3498663201892;1244.4089057697702;1251.1554700577074;23998.280051598478;25073.49853002966;25266.494670106127;25296.11463598839;25306.493870122864;37547.43678844765;38115.61884381121;38149.427758583086;38215.80892095522;38259.61740382672;224756;226708;315988.30087743973;321512;323240;28930;28944.42111157807;28969.420611588073;28974.27564310909;29377;36750;37666.623333766314;37919.241615168095;38176.42735358916;38488.422673660476;31117.96345637628;31809.522857157623;32232.35535289234;32547.18632034218;32618;32394.83802580972;32792.672073279915;36788.264234715694;38247.6175238244;38280.42579361256;32649.510257346636;33138.33723325568;33144.66855331416;33165;33201.169970750925;31637.8418107908;31862.840685796422;34338.48492272568;34608.65391346054;34755.30489390148;23278.185263515697;23955.880220598785;23977.52044959126;24818;26517.734822651528 19:55:02 INFO - 2015-12-02 19:55:02,495 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.74686491401604;329.6917382247597;332.247459504223;333.8380885270643;334.5483597143856;11907.7618447631;12129.393530323492;14712.632184195387;15164.848351516495;15902.363905443783;11656.009239214676;14280.214588197645;14773.556793296191;15312;15312.69374612507;4607.562281583261;4610.216263235241;4816.124328319444;4823.614110871139;4964.205727083668;3550.5916819565823;3633.7638053526434;4902.338184345122;4954.7522623868845;5572.916406253909;5646.971765141168;5669.149627555879;5677.9495793278165;5681.857953551153;5693.914591281134;5283.207518872181;5665.12190610456;5768.451997060272;5782.392848750905;5783.450572195635;5048.899022019576;5050.39395272566;5058.721770302632;5064.670796398223;5068;18538.907305463385;18562.814371856242;18690.906545467322;18696.90651546747;19472;1844.2807305151002;1860.125740901774;1866.2628261836635;1956.8238858502802;1992.372402693147;12300.569480068154;12385.637579866208;12657;12772.297523636196;12809;1717.8625709943299;1754.7192449208064;1771.5128339706555;1779.661864245789;1788.9910550447294;49744;50468.747656261854;51218.7439062806;52657.2101418479;54702.17946730802;9144.405613635092;9501.334906556613;9678.467684277291;9680.419174849532;9727;12320.630381088582;12334.629961101182;12343.567975120828;12345;12374.938125309496;6392.648404337806;6406.807795766134;6440.516961227833;6520.967395162994;6599.505037122235;6088.4824789893355;6111.8472038198515;6170.167027451326;6180.196574445294;6186;4050.10897602527;4114.917701645951;4116.444280022159;4122.299209134454;4142.357934520154;1601.66365063338;1622.6673531925926;1652.6529428819842;1727.9308827647005;1772.7252275897256;815.8572249856252;845.6279237135764;848.9108643592334;866.5017614871474;882.8278485695228;15262.694746105015;15684.294206760724;15868;16011.439599613957;16088.678226435406;840.4663038970176;848.321342925657;850.991574983634;858.8883445152215;862.2239984014437;8852;9094.727158185266;9132.3150763693;9186.586603602855;9198.540072996324;460311;460683;463119;465006;465051;66755;68475;69048.47612191012;69074;69831.3016869835;1009.1018993096151;1027;1073.9892601073889;1084.0677017764715;1088.1403691083956;13838.584842454742;13874.722505550035;14078.788818167532;14347.713045739236;14372.065815721944;31996.84001579977;32114.678853211168;32224.516632250066;32596.83701581477;33000.33999319952;41526.377104344065;42291.36562951496;42886.57113428826;42997.35503967381;44598.55401446074;8843.778905527413;8904.19862212404;8945.19493245611;9021.188093071654;9022.639094436148;15774.684506310039;15852.841471585136;16030.67938641244;16212.918935405247;16380.67238655244;10518.684439466828;10636.30863993838;13263.270520121487;13589.388477518733;13655.385507651981;12547.372631368578;12734.61796146117;12981.740365192833;13024.8046279304;13605.86394136046;10067.546960386653;10412.68761937143;12083.577074802692;13373.933130334286;13379.464821407424;8049.718259860877;8373.204545568162;8474.27968622674;8485.236328730198;9079.228265597498;13190.934045329712;13470.326483675974;13743.381547830171;13939.790903136663;14210.786838197642 19:55:02 INFO - 2015-12-02 19:55:02,495 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1221.200113925378;1676.7987841459026;1725.6376161006187;1742.4162905426685;1751.9562010949724;6267.937320626792;7073.257307982665;7242.456815738814;7253.601051942141;7265.564066156027;7097.041899343587;7284.854302913952;7285.41716662667;7290.562566246029;7298.744543940963;1781.3052909365358;1821.025751223096;1822.6263615958696;2070.9792902070976;2115.481706981784;1782.6434713057376;1786.8927864328116;1790.1407324484255;2062.5153089024066;2110.2930518276394;2047.6928460730935;2059.6292667319876;2062.05145633009;2063.3912995666315;2063.4016135320812;1991.1139542903413;2045;2047.672372420413;2047.9692804607944;2048.836093112555;2074.8651337663155;2094.4135642020105;2095.434232757162;2101.8949052547464;2143.3248526714037;7060.470464715167;7110.075690160246;7152.7496537621455;7154.105736782903;7164.426845852319;4105.91788164238;4163.604457576525;4173.436586060873;4176.979115104436;4178.8328466861285;2669.2526092694075;2681.6647919010124;2695.420484595821;2713.4573085383004;2744.7666948309416;830.6137645994642;843.9704610338608;845.450457202823;863.2921004776086;1624.2771966474922;9447.480388578626;9546.331756777028;9554.952225238829;9574.952125239399;9589.280803939733;3677.9448308275396;3704.4072948328676;3801.8669346572738;3867.9226415471535;3878.3406820840523;7828.45200835936;7846.450748447668;7858.960705196552;7867.763967080997;7868.44920855546;4063.6342729154517;4063.837446502107;4074.1851629674184;4113.938290925578;4122.175564887035;3762.3792074307435;3799.544054713452;3804.4673745675627;3807.0862992881507;3809.8666546670734;3049.35963447674;3057.7248047675816;3097.535369694564;3120.157557459473;3126.1715645353997;865.5628907401848;874.61079819481;886.3441053620274;895.5880295064343;944.9102335278137;889.4574309671095;922.1608336413831;962.8892677342055;965.3676841668719;1014.2849291249652;6658.201015878126;6700.83247918806;6711.865762684816;6726.697298621574;6733.696983635748;544.104947361588;706.6254884911006;1096.6770684824994;1129.5651174297955;1145.616218566773;5404.351477822608;5428.995635807389;5430.239766432703;5452.6183167177915;5456.072467680504;8285.83428331442;8498;8622.439541429912;8640.481571105754;8681.262092722063;8525.23272905429;8630.223279904838;8691.34814888886;8694.26098781598;8696.260817830429;6574.934250657528;6722.731090756315;6763.5941843489545;6800.761973331008;6831.658417079127;6756.763513277012;6814.284500127415;6816.2502124767225;6824.897626535507;6829.726810927507;7498.775036748906;7576.24237576238;7736.419768517271;7737.613119344122;7762;7724.729634462767;7890.566018868788;7909.090454597795;7982.6008699565955;7983.481073730189;6222.377762223741;6274.968625156845;6340.651264180515;6354.872902542016;6369.45859601939;6811.795646130624;6882.174139103339;6896.551724137915;6907.6891539881835;6924.723011079501;5672.234248376416;5742.425757424224;6455.903161452676;6472.126262954441;6606.900896486461;6360.4275615193;6438.356164383524;6468.611883287018;6494.967525162344;6561.409473147249;6445.742170313135;6475.805725828232;6483.610983341015;6507.837304067436;6509.967450162719;5402.945970540244;5420.349558053059;5420.4037555868035;5421.024215641222;5443.673379597237;6134.907976380268;6145.262568491809;6148.938510614837;6149.907751383822;6166.845828854135 19:55:02 INFO - 2015-12-02 19:55:02,495 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.10485257832164;298.1368936927595;300.8360443558261;302.9575859379686;305.8333208401422;5145.485451454852;5265.631405801595;5294.761735721892;5304.761285742141;5369.838904832852;5134.563562097226;5251;5296.9735151324285;5298.178782288742;5301.6818990860575;4085.0195952971294;4086.346184610463;4092.89767755807;4095.0786073133604;4095.672346212296;3905.941410878839;3991.042149884036;4040.9797951010205;4074.2055299216663;4082;4021.5174179098403;4035.152617950234;4035.919281614366;4038.5355684096266;4072.9185416291657;4055.918881622366;4067.8169482373364;4070.959290407088;4072.1652061327504;4079.714419990602;3549.4853246279145;3552.0942159749097;3553.6091029986683;3557.2529768748595;3565.1978304881195;4970.925436118461;5086.491350864921;5119.923201151985;5121.334226550562;5169.767360468788;4682.040181762764;4683.133620280225;4687.531246875285;4691.530846915315;4691.7332320273335;5586.972065139689;5594.776208951678;5610.887782244373;5611.046122159202;5613.971930140364;3630.618785027587;3737.738358314919;3738.065483629093;3840.8655697050467;3849.4610754494392;5799.18811366409;5846.035404158309;5859.238299021143;5860.4725574698905;5864.53083753303;3928.9981054830837;3932.528096628423;3936.3111455495173;3947.3289540778137;3948.1116748731306;4011.7764081955283;4013.2174226026227;4014.759114453142;4016.136530645925;4020.557738648746;4501.707389019703;4565.794539245742;4600.953990460052;4608.377868987711;4609.585137337589;5544.556435485151;5549.7780088796;5554.444555544414;5559.249501317351;5562.749676264578;1406.1000959386001;1425.187643043476;1427.3790900958115;1427.964300892486;1430.1633544376448;949.7103383468109;953.9189168920581;959.1271942532402;973.8101070291367;974.1378879691382;4922.360093187863;4923.655344125877;4923.926141107886;4926.926096108561;4928.831314221731;5795.275590551181;5806.129080637854;5809.331926828384;5812.709364531841;5814.244148260699;4921;4924.72913989734;4927.457979622239;4928.556429921325;4933.358663373739;3060.540918862144;3110.0669799060192;3125.5780469636306;3140.183552276379;3141.104785136225;5509.228707980886;5511.5039646432015;5514.283143191359;5516.448355164532;5518.751656175482;5926.8814623707285;5936.168936348915;5939.227900372924;5939.287285525765;5947.256592925884;5507.091329930597;5508.944910550843;5509.421510741315;5513.641613295123;5518.034343989705;5600.60795744294;5770.653760774367;5775.306963164448;5775.9133612995;5785.9874521957645;5450.345958485007;5502.80740174092;5580.190872323409;5607.271054762855;5623.971880140737;5538.670719027324;5545.667259964415;5562.7774889005605;5569.303837020372;5577.609567330248;3920.098377373163;3920.5295364556437;3920.7059470539252;3921.0785465415033;3926.862559810393;5805.3033635962265;5815.6219845711585;5818.505427038749;5826.504747096545;5828.746819433842;5458;5624.465675760796;5627.915581266366;5630.296212973379;5635.633683810539;5622;5630.0991841305195;5630.18362337467;5634.661920284796;5638.182463542681;5498.945010549844;5499.450054994469;5503.2020357048805;5506.201600767786;5515.669059856422;5527.723613819373;5646.689432081275;5654.886902262014;5659.292588426447;5662.85842853932;5486.231927530229;5494.862628434321;5495.258140151188;5497.587680923867;5502.174673798962 19:55:02 INFO - 2015-12-02 19:55:02,496 DEBUG : BROWSER_OUTPUT: |5;yui.html;705.6224919667977;785.9214078592138;810.9513429194249;811.2252798577359;821.0475848016306;10099.545520451578;10207.897921020778;10209.081182693575;10230;10233.692989210316;10275.588976440951;11560.537578496871;11674.649760507198;11718.062554995602;11719.179657423983;802.8434455281238;816.8366326734647;816.9591520423985;817.8650522663753;817.9141190175035;803.6303300481785;810.4245985350408;810.5663470043528;811.0186674124317;812.0336799208952;848.0671261612239;856.1010938514565;857.2284943550792;857.3312816003527;862.8619420892659;852.5311078906576;853.8420392227458;853.9829203415928;854.1671869926834;854.5043874552775;627.6767464755654;633.072548716133;633.8066889598671;634.1945728924286;634.4765568406037;11917.106217033757;11925.582604608884;12032.39838008105;12033.57882474118;12066.034717222601;11267.718307042307;11328;11330.773384532346;11342.48958796848;11485.196036277464;9741.707748767478;9770.755731106708;9806.117449429586;9893.604255829758;9915.454649994248;3273.8363081845814;3287;3315.088350703552;3396.2188696599674;3414.709749671281;33387.16532086693;34317.485237721456;36218.818905905304;37207.25585488275;37475.25049499049;8971.730848074569;9023.503707296162;9102.089791020977;9206.677766278148;9439.24486041115;16319.592010199602;16373.181340932906;16498.25757840876;16540.09029503365;16541.917290413712;6354.205724284465;6371.299157092716;6385.297617262097;6477.740890364333;6615.636140012345;3598.586162591283;3601.333753255656;3611.7110631149444;3622.8188590570367;3657.762245454037;2790;2799.664040315175;2810;2819.718028197205;2830.051932602601;512.8000079968815;517.5911030286107;523.6308402576251;528.3685995235656;528.9576833853282;487.36885732975884;539.7490167072331;587.5469913112737;627.47737271067;628.8742251549709;7581.696732130763;7777.105632852181;7853.960730196312;7896.842063158705;7991.680332786624;477.0816178855689;494.3227777944239;520.3313741841715;536.9033573956725;585.4906231578553;3456.792592444461;3592.6227746086806;3603.189282411489;3988.3618621020496;4023;48416;48864.26703599449;49320.260196097086;49408.75295623571;49433.50566494361;42938;42954.355684664755;42978.355324670156;43170.35244471335;43619.34570981438;36433.453498197545;42742;42885.571144288784;42942.14115717668;43403.56596434058;7884.6057697113765;8009.759707208793;8218.260356567938;8245.587720614065;8469.449485783405;31123.377532448772;32191;32336.514952275265;32341.604131565848;32391.51412728858;38513.7327934415;39848.402273966494;40016.19967600574;40091.1981760369;42252;8879.378443508893;10123;10204.744881378025;10335.793284134124;10549.997750213717;11154.776904461703;11300;11368.204225704121;11612.825807612724;12015.158938874194;10164.186865050926;10310.690679279634;10314.174866010851;10770.407627580558;10870.782584348426;10917.890821092005;10947.671569852917;11015.118790496901;11216.775664486502;11381.829272560753;10293.073623373932;10312.690619281433;10758.569657213624;10960.342379457257;11305;9239.168474837297;9293.117153870371;9314.347995640512;9504.762380940532;9525.285603579621;8692.217700406994;9107.362484626012;9182.17360437564;9350.345475816628;9504.382215155993 19:55:02 INFO - 2015-12-02 19:55:02,496 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:55:02 INFO - 2015-12-02 19:55:02,496 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:55:02 INFO - 2015-12-02 19:55:02,496 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 19:55:02 INFO - 2015-12-02 19:55:02,497 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:55:02 INFO - 2015-12-02 19:55:02,497 DEBUG : BROWSER_OUTPUT: __startTimestamp1449114902486__endTimestamp 19:55:02 INFO - 2015-12-02 19:55:02,497 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,497 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:55:02 INFO - 2015-12-02 19:55:02,497 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:55:02 INFO - 2015-12-02 19:55:02,497 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,497 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4632.76 Median:4800.59 stddev:496.25 (10.3%) stddev-sans-first:471.67 19:55:02 INFO - 2015-12-02 19:55:02,498 DEBUG : BROWSER_OUTPUT: Values: 2608.0 2616.7 2617.2 2631.3 2638.6 4563.1 4609.8 4612.8 4626.3 4684.8 4609.3 4642.3 4677.6 4713.2 4746.4 4096.0 4334.1 4342.6 4374.7 4403.1 4402.2 4420.6 4436.7 4445.0 4476.9 4154.3 4252.1 4252.9 4269.6 4395.6 4291.8 4295.0 4299.8 4327.6 4331.0 4273.4 4274.7 4277.2 4327.1 4329.6 4443.4 4562.2 4577.7 4595.9 4701.1 5044.3 5047.8 5069.6 5073.1 5115.1 5091.5 5093.8 5098.4 5098.5 5106.0 4529.4 4582.7 4643.4 4646.0 4719.6 5150.3 5177.5 5178.7 5182.5 5183.6 4954.0 4955.3 4956.3 4958.5 4998.4 4864.6 4866.9 4972.9 4975.2 4986.6 5024.6 5038.0 5043.5 5060.8 5078.2 4971.4 4974.9 4975.9 4977.5 5018.6 4033.3 4145.5 4193.2 4197.4 4236.3 3582.4 3634.5 3657.9 3671.4 3676.5 4378.8 4384.6 4386.6 4395.0 4421.5 5082.0 5087.0 5089.2 5093.2 5129.6 4221.0 4278.8 4317.8 4320.1 4321.7 4484.0 4495.5 4502.5 4513.7 4529.0 4828.9 4829.1 4834.6 4838.5 4870.7 4806.5 4896.0 4899.6 5072.4 5081.1 4729.7 4800.6 4835.3 4837.0 4847.4 4959.6 4966.7 4969.1 4972.2 5015.8 4841.5 5036.7 5036.9 5049.3 5049.4 4773.0 4848.4 4859.4 4890.4 4892.5 4858.3 4900.7 4904.9 4912.2 4946.8 4669.4 4761.1 4775.1 4782.9 4825.5 4808.8 4848.2 4868.3 4884.5 4937.4 4791.3 4802.0 4807.0 4811.3 4836.6 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42619.06 Median:17824.55 stddev:72190.22 (405.0%) stddev-sans-first:72323.62 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: Values: 549.9 557.5 571.1 573.3 574.0 27450.6 28008.4 28200.9 28225.6 35914.5 39921.2 40290.4 40302.6 40310.6 40443.6 7757.0 7875.8 7923.6 7931.8 7937.1 7131.8 7338.2 7757.9 9980.6 10275.2 9949.0 10059.5 10062.6 10066.0 10067.3 7127.9 9795.4 9919.7 9923.3 9945.1 7028.1 9723.3 9980.4 9994.8 10000.9 33093.7 33449.2 33492.0 33527.3 33529.2 2823.3 2848.3 2948.0 3162.5 3355.5 27646.7 27930.7 28204.4 28253.4 28330.6 3138.4 3209.1 3227.9 3254.3 3279.5 207995.0 208738.0 208962.0 210346.0 210523.0 49749.5 51344.0 55455.7 55543.7 55573.4 58510.1 59448.7 59642.7 59652.7 59679.6 13500.1 13894.9 13897.4 13907.7 13925.4 10390.1 10482.2 10527.6 10533.1 10536.4 18805.5 19028.7 19075.3 19092.3 19118.5 7358.2 7574.3 7701.5 7735.6 7745.2 875.7 910.7 974.4 988.2 989.3 25853.5 25869.2 26050.5 26210.7 26225.0 955.6 979.2 1026.8 1039.2 1084.9 13119.6 13132.6 13300.9 13519.8 13528.8 315969.0 317404.8 319821.0 320268.0 322639.0 44390.8 45011.8 45106.5 45151.5 45210.0 1211.4 1226.5 1238.3 1244.4 1251.2 23998.3 25073.5 25266.5 25296.1 25306.5 37547.4 38115.6 38149.4 38215.8 38259.6 224756.0 226708.0 315988.3 321512.0 323240.0 28930.0 28944.4 28969.4 28974.3 29377.0 36750.0 37666.6 37919.2 38176.4 38488.4 31118.0 31809.5 32232.4 32547.2 32618.0 32394.8 32792.7 36788.3 38247.6 38280.4 32649.5 33138.3 33144.7 33165.0 33201.2 31637.8 31862.8 34338.5 34608.7 34755.3 23278.2 23955.9 23977.5 24818.0 26517.7 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25393.51 Median:3592.18 stddev:75539.35 (2102.9%) stddev-sans-first:75727.82 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: Values: 328.7 329.7 332.2 333.8 334.5 11907.8 12129.4 14712.6 15164.8 15902.4 11656.0 14280.2 14773.6 15312.0 15312.7 4607.6 4610.2 4816.1 4823.6 4964.2 3550.6 3633.8 4902.3 4954.8 5572.9 5647.0 5669.1 5677.9 5681.9 5693.9 5283.2 5665.1 5768.5 5782.4 5783.5 5048.9 5050.4 5058.7 5064.7 5068.0 18538.9 18562.8 18690.9 18696.9 19472.0 1844.3 1860.1 1866.3 1956.8 1992.4 12300.6 12385.6 12657.0 12772.3 12809.0 1717.9 1754.7 1771.5 1779.7 1789.0 49744.0 50468.7 51218.7 52657.2 54702.2 9144.4 9501.3 9678.5 9680.4 9727.0 12320.6 12334.6 12343.6 12345.0 12374.9 6392.6 6406.8 6440.5 6521.0 6599.5 6088.5 6111.8 6170.2 6180.2 6186.0 4050.1 4114.9 4116.4 4122.3 4142.4 1601.7 1622.7 1652.7 1727.9 1772.7 815.9 845.6 848.9 866.5 882.8 15262.7 15684.3 15868.0 16011.4 16088.7 840.5 848.3 851.0 858.9 862.2 8852.0 9094.7 9132.3 9186.6 9198.5 460311.0 460683.0 463119.0 465006.0 465051.0 66755.0 68475.0 69048.5 69074.0 69831.3 1009.1 1027.0 1074.0 1084.1 1088.1 13838.6 13874.7 14078.8 14347.7 14372.1 31996.8 32114.7 32224.5 32596.8 33000.3 41526.4 42291.4 42886.6 42997.4 44598.6 8843.8 8904.2 8945.2 9021.2 9022.6 15774.7 15852.8 16030.7 16212.9 16380.7 10518.7 10636.3 13263.3 13589.4 13655.4 12547.4 12734.6 12981.7 13024.8 13605.9 10067.5 10412.7 12083.6 13373.9 13379.5 8049.7 8373.2 8474.3 8485.2 9079.2 13190.9 13470.3 13743.4 13939.8 14210.8 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,499 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4949.62 Median:6442.05 stddev:2599.01 (40.3%) stddev-sans-first:2591.19 19:55:02 INFO - 2015-12-02 19:55:02,500 DEBUG : BROWSER_OUTPUT: Values: 1221.2 1676.8 1725.6 1742.4 1752.0 6267.9 7073.3 7242.5 7253.6 7265.6 7097.0 7284.9 7285.4 7290.6 7298.7 1781.3 1821.0 1822.6 2071.0 2115.5 1782.6 1786.9 1790.1 2062.5 2110.3 2047.7 2059.6 2062.1 2063.4 2063.4 1991.1 2045.0 2047.7 2048.0 2048.8 2074.9 2094.4 2095.4 2101.9 2143.3 7060.5 7110.1 7152.7 7154.1 7164.4 4105.9 4163.6 4173.4 4177.0 4178.8 2669.3 2681.7 2695.4 2713.5 2744.8 830.6 844.0 845.5 863.3 1624.3 9447.5 9546.3 9555.0 9575.0 9589.3 3677.9 3704.4 3801.9 3867.9 3878.3 7828.5 7846.5 7859.0 7867.8 7868.4 4063.6 4063.8 4074.2 4113.9 4122.2 3762.4 3799.5 3804.5 3807.1 3809.9 3049.4 3057.7 3097.5 3120.2 3126.2 865.6 874.6 886.3 895.6 944.9 889.5 922.2 962.9 965.4 1014.3 6658.2 6700.8 6711.9 6726.7 6733.7 544.1 706.6 1096.7 1129.6 1145.6 5404.4 5429.0 5430.2 5452.6 5456.1 8285.8 8498.0 8622.4 8640.5 8681.3 8525.2 8630.2 8691.3 8694.3 8696.3 6574.9 6722.7 6763.6 6800.8 6831.7 6756.8 6814.3 6816.3 6824.9 6829.7 7498.8 7576.2 7736.4 7737.6 7762.0 7724.7 7890.6 7909.1 7982.6 7983.5 6222.4 6275.0 6340.7 6354.9 6369.5 6811.8 6882.2 6896.6 6907.7 6924.7 5672.2 5742.4 6455.9 6472.1 6606.9 6360.4 6438.4 6468.6 6495.0 6561.4 6445.7 6475.8 6483.6 6507.8 6510.0 5402.9 5420.3 5420.4 5421.0 5443.7 6134.9 6145.3 6148.9 6149.9 6166.8 19:55:02 INFO - 2015-12-02 19:55:02,501 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,501 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4618.26 Median:5297.58 stddev:1371.81 (25.9%) stddev-sans-first:1336.65 19:55:02 INFO - 2015-12-02 19:55:02,502 DEBUG : BROWSER_OUTPUT: Values: 291.1 298.1 300.8 303.0 305.8 5145.5 5265.6 5294.8 5304.8 5369.8 5134.6 5251.0 5297.0 5298.2 5301.7 4085.0 4086.3 4092.9 4095.1 4095.7 3905.9 3991.0 4041.0 4074.2 4082.0 4021.5 4035.2 4035.9 4038.5 4072.9 4055.9 4067.8 4071.0 4072.2 4079.7 3549.5 3552.1 3553.6 3557.3 3565.2 4970.9 5086.5 5119.9 5121.3 5169.8 4682.0 4683.1 4687.5 4691.5 4691.7 5587.0 5594.8 5610.9 5611.0 5614.0 3630.6 3737.7 3738.1 3840.9 3849.5 5799.2 5846.0 5859.2 5860.5 5864.5 3929.0 3932.5 3936.3 3947.3 3948.1 4011.8 4013.2 4014.8 4016.1 4020.6 4501.7 4565.8 4601.0 4608.4 4609.6 5544.6 5549.8 5554.4 5559.2 5562.7 1406.1 1425.2 1427.4 1428.0 1430.2 949.7 953.9 959.1 973.8 974.1 4922.4 4923.7 4923.9 4926.9 4928.8 5795.3 5806.1 5809.3 5812.7 5814.2 4921.0 4924.7 4927.5 4928.6 4933.4 3060.5 3110.1 3125.6 3140.2 3141.1 5509.2 5511.5 5514.3 5516.4 5518.8 5926.9 5936.2 5939.2 5939.3 5947.3 5507.1 5508.9 5509.4 5513.6 5518.0 5600.6 5770.7 5775.3 5775.9 5786.0 5450.3 5502.8 5580.2 5607.3 5624.0 5538.7 5545.7 5562.8 5569.3 5577.6 3920.1 3920.5 3920.7 3921.1 3926.9 5805.3 5815.6 5818.5 5826.5 5828.7 5458.0 5624.5 5627.9 5630.3 5635.6 5622.0 5630.1 5630.2 5634.7 5638.2 5498.9 5499.5 5503.2 5506.2 5515.7 5527.7 5646.7 5654.9 5659.3 5662.9 5486.2 5494.9 5495.3 5497.6 5502.2 19:55:02 INFO - 2015-12-02 19:55:02,502 DEBUG : BROWSER_OUTPUT: 19:55:02 INFO - 2015-12-02 19:55:02,502 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12135.05 Median:43074.35 stddev:13541.94 (31.4%) stddev-sans-first:13552.72 19:55:02 INFO - 2015-12-02 19:55:02,502 DEBUG : BROWSER_OUTPUT: Values: 705.6 785.9 811.0 811.2 821.0 10099.5 10207.9 10209.1 10230.0 10233.7 10275.6 11560.5 11674.6 11718.1 11719.2 802.8 816.8 817.0 817.9 817.9 803.6 810.4 810.6 811.0 812.0 848.1 856.1 857.2 857.3 862.9 852.5 853.8 854.0 854.2 854.5 627.7 633.1 633.8 634.2 634.5 11917.1 11925.6 12032.4 12033.6 12066.0 11267.7 11328.0 11330.8 11342.5 11485.2 9741.7 9770.8 9806.1 9893.6 9915.5 3273.8 3287.0 3315.1 3396.2 3414.7 33387.2 34317.5 36218.8 37207.3 37475.3 8971.7 9023.5 9102.1 9206.7 9439.2 16319.6 16373.2 16498.3 16540.1 16541.9 6354.2 6371.3 6385.3 6477.7 6615.6 3598.6 3601.3 3611.7 3622.8 3657.8 2790.0 2799.7 2810.0 2819.7 2830.1 512.8 517.6 523.6 528.4 529.0 487.4 539.7 587.5 627.5 628.9 7581.7 7777.1 7854.0 7896.8 7991.7 477.1 494.3 520.3 536.9 585.5 3456.8 3592.6 3603.2 3988.4 4023.0 48416.0 48864.3 49320.3 49408.8 49433.5 42938.0 42954.4 42978.4 43170.4 43619.3 36433.5 42742.0 42885.6 42942.1 43403.6 7884.6 8009.8 8218.3 8245.6 8469.4 31123.4 32191.0 32336.5 32341.6 32391.5 38513.7 39848.4 40016.2 40091.2 42252.0 8879.4 10123.0 10204.7 10335.8 10550.0 11154.8 11300.0 11368.2 11612.8 12015.2 10164.2 10310.7 10314.2 10770.4 10870.8 10917.9 10947.7 11015.1 11216.8 11381.8 10293.1 10312.7 10758.6 10960.3 11305.0 9239.2 9293.1 9314.3 9504.8 9525.3 8692.2 9107.4 9182.2 9350.3 9504.4 19:55:02 INFO - 2015-12-02 19:55:02,502 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:55:02 INFO - 2015-12-02 19:55:02,502 DEBUG : BROWSER_OUTPUT: 19:55:03 INFO - 2015-12-02 19:55:03,277 INFO : Browser exited with error code: 0 19:55:03 INFO - 2015-12-02 19:55:03,293 INFO : Completed test dromaeo_css (00:18:36) 19:55:03 INFO - 2015-12-02 19:55:03,294 INFO : Starting test kraken 19:55:03 INFO - 2015-12-02 19:55:03,294 DEBUG : operating with platform_type : linux_ 19:55:03 INFO - 2015-12-02 19:55:03,294 INFO : Initialising browser for kraken test... 19:55:03 INFO - 2015-12-02 19:55:03,300 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJawSD/profile http://localhost:54184/getInfo.html 19:55:07 INFO - 2015-12-02 19:55:07,455 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:55:07 INFO - 2015-12-02 19:55:07,455 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:55:07 INFO - 2015-12-02 19:55:07,455 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:55:07 INFO - 2015-12-02 19:55:07,455 DEBUG : BROWSER_OUTPUT: __metrics 19:55:07 INFO - 2015-12-02 19:55:07,511 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:55:07 INFO - 2015-12-02 19:55:07,512 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:55:08 INFO - 2015-12-02 19:55:08,368 INFO : Browser initialized. 19:55:08 INFO - 2015-12-02 19:55:08,369 INFO : Running cycle 1/1 for kraken test... 19:55:08 INFO - 2015-12-02 19:55:08,369 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJawSD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:55:20 INFO - 2015-12-02 19:55:20,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 143163392 19:55:20 INFO - 2015-12-02 19:55:20,333 DEBUG : BROWSER_OUTPUT: 19:55:22 INFO - 2015-12-02 19:55:22,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54184/tests/kraken/driver.html?testName=audio-beat-detection) 19:55:23 INFO - 2015-12-02 19:55:23,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 182968320 19:55:23 INFO - 2015-12-02 19:55:23,523 DEBUG : BROWSER_OUTPUT: 19:55:26 INFO - 2015-12-02 19:55:26,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54184/tests/kraken/driver.html?testName=audio-dft) 19:55:26 INFO - 2015-12-02 19:55:26,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 170242048 19:55:26 INFO - 2015-12-02 19:55:26,830 DEBUG : BROWSER_OUTPUT: 19:55:29 INFO - 2015-12-02 19:55:29,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54184/tests/kraken/driver.html?testName=audio-fft) 19:55:30 INFO - 2015-12-02 19:55:30,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 153141248 19:55:30 INFO - 2015-12-02 19:55:30,410 DEBUG : BROWSER_OUTPUT: 19:55:32 INFO - 2015-12-02 19:55:32,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54184/tests/kraken/driver.html?testName=audio-oscillator) 19:55:33 INFO - 2015-12-02 19:55:33,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 155795456 19:55:33 INFO - 2015-12-02 19:55:33,044 DEBUG : BROWSER_OUTPUT: 19:55:35 INFO - 2015-12-02 19:55:35,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:55:35 INFO - 2015-12-02 19:55:35,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 156479488 19:55:35 INFO - 2015-12-02 19:55:35,870 DEBUG : BROWSER_OUTPUT: 19:55:38 INFO - 2015-12-02 19:55:38,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54184/tests/kraken/driver.html?testName=imaging-darkroom) 19:55:39 INFO - 2015-12-02 19:55:39,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 158605312 19:55:39 INFO - 2015-12-02 19:55:39,455 DEBUG : BROWSER_OUTPUT: 19:55:42 INFO - 2015-12-02 19:55:42,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54184/tests/kraken/driver.html?testName=imaging-desaturate) 19:55:43 INFO - 2015-12-02 19:55:43,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 157081600 19:55:43 INFO - 2015-12-02 19:55:43,461 DEBUG : BROWSER_OUTPUT: 19:55:46 INFO - 2015-12-02 19:55:46,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54184/tests/kraken/driver.html?testName=json-parse-financial) 19:55:46 INFO - 2015-12-02 19:55:46,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 159199232 19:55:46 INFO - 2015-12-02 19:55:46,881 DEBUG : BROWSER_OUTPUT: 19:55:48 INFO - 2015-12-02 19:55:48,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:55:49 INFO - 2015-12-02 19:55:49,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 169144320 19:55:49 INFO - 2015-12-02 19:55:49,217 DEBUG : BROWSER_OUTPUT: 19:55:51 INFO - 2015-12-02 19:55:51,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:55:51 INFO - 2015-12-02 19:55:51,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 167862272 19:55:51 INFO - 2015-12-02 19:55:51,721 DEBUG : BROWSER_OUTPUT: 19:55:53 INFO - 2015-12-02 19:55:53,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:55:54 INFO - 2015-12-02 19:55:54,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 180023296 19:55:54 INFO - 2015-12-02 19:55:54,435 DEBUG : BROWSER_OUTPUT: 19:55:56 INFO - 2015-12-02 19:55:56,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:55:57 INFO - 2015-12-02 19:55:57,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 185634816 19:55:57 INFO - 2015-12-02 19:55:57,521 DEBUG : BROWSER_OUTPUT: 19:56:00 INFO - 2015-12-02 19:56:00,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:00 INFO - 2015-12-02 19:56:00,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 183386112 19:56:00 INFO - 2015-12-02 19:56:00,752 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54184/tests/kraken/driver.html?testName=ai-astar) 19:56:02 INFO - 2015-12-02 19:56:02,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 241143808 19:56:02 INFO - 2015-12-02 19:56:02,765 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,768 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:56:02 INFO - 2015-12-02 19:56:02,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:56:02 INFO - 2015-12-02 19:56:02,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:56:02 INFO - 2015-12-02 19:56:02,768 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:56:02 INFO - 2015-12-02 19:56:02,768 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;104;111;113;112;99;110;110;104 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;131;159;176;127;155;151;139;172;129 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;159;161;162;163;161;162 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;83;91;72;73;73;117;86;72 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;131;93;95;95;130;95;95;144 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;109;110;110;109;109 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;146;147;146;146;148;147;147 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;73;70;70;70;70;80;68;68 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;70;68;68;69;69 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;82;84;84;81;83;85;84;84 19:56:02 INFO - 2015-12-02 19:56:02,769 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;125;126;122;127;125;126;120;120;119 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;141;147;161;149;135;163;147;146;138 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;67;68;70;68;69;67;72;68;69 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1003 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: __startTimestamp1449114962767__endTimestamp 19:56:02 INFO - 2015-12-02 19:56:02,770 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,773 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:56:02 INFO - 2015-12-02 19:56:02,773 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:56:02 INFO - 2015-12-02 19:56:02,773 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,773 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:111.00 stddev:4.47 (4.0%) stddev-sans-first:4.74 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 104.0 111.0 113.0 112.0 99.0 110.0 110.0 104.0 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.00 stddev:17.45 (11.3%) stddev-sans-first:18.39 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: Values: 155.0 131.0 159.0 176.0 127.0 155.0 151.0 139.0 172.0 129.0 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 159.0 161.0 162.0 163.0 161.0 162.0 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:73.00 stddev:14.31 (19.6%) stddev-sans-first:14.86 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 83.0 91.0 72.0 73.0 73.0 117.0 86.0 72.0 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:94.50 stddev:19.95 (21.1%) stddev-sans-first:20.63 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 131.0 93.0 95.0 95.0 130.0 95.0 95.0 144.0 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:56:02 INFO - 2015-12-02 19:56:02,774 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 147.0 146.0 146.0 148.0 147.0 147.0 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.00 Median:70.00 stddev:3.46 (4.9%) stddev-sans-first:3.67 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 73.0 70.0 70.0 70.0 70.0 80.0 68.0 68.0 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 70.0 68.0 68.0 69.0 69.0 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.00 stddev:1.29 (1.5%) stddev-sans-first:1.30 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 82.0 84.0 84.0 81.0 83.0 85.0 84.0 84.0 19:56:02 INFO - 2015-12-02 19:56:02,775 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:125.00 stddev:2.94 (2.3%) stddev-sans-first:3.08 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: Values: 122.0 125.0 126.0 122.0 127.0 125.0 126.0 120.0 120.0 119.0 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:148.00 stddev:9.09 (6.1%) stddev-sans-first:9.46 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: Values: 153.0 141.0 147.0 161.0 149.0 135.0 163.0 147.0 146.0 138.0 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.55 (2.2%) stddev-sans-first:1.58 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: Values: 70.0 67.0 68.0 70.0 68.0 69.0 67.0 72.0 68.0 69.0 19:56:02 INFO - 2015-12-02 19:56:02,776 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:56:02 INFO - 2015-12-02 19:56:02,777 DEBUG : BROWSER_OUTPUT: 19:56:03 INFO - 2015-12-02 19:56:03,629 INFO : Browser exited with error code: 0 19:56:03 INFO - 2015-12-02 19:56:03,682 INFO : Completed test kraken (00:01:00) 19:56:03 INFO - 2015-12-02 19:56:03,682 INFO : Starting test v8_7 19:56:03 INFO - 2015-12-02 19:56:03,682 DEBUG : operating with platform_type : linux_ 19:56:03 INFO - 2015-12-02 19:56:03,683 INFO : Initialising browser for v8_7 test... 19:56:03 INFO - 2015-12-02 19:56:03,688 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPoNapj/profile http://localhost:54184/getInfo.html 19:56:07 INFO - 2015-12-02 19:56:07,603 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:56:07 INFO - 2015-12-02 19:56:07,603 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:56:07 INFO - 2015-12-02 19:56:07,603 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:56:07 INFO - 2015-12-02 19:56:07,603 DEBUG : BROWSER_OUTPUT: __metrics 19:56:07 INFO - 2015-12-02 19:56:07,704 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:56:07 INFO - 2015-12-02 19:56:07,704 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:08 INFO - 2015-12-02 19:56:08,857 INFO : Browser initialized. 19:56:08 INFO - 2015-12-02 19:56:08,858 INFO : Running cycle 1/1 for v8_7 test... 19:56:08 INFO - 2015-12-02 19:56:08,858 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPoNapj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:56:20 INFO - 2015-12-02 19:56:20,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 143540224 19:56:20 INFO - 2015-12-02 19:56:20,835 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54184/tests/v8_7/run.html (next: http://localhost:54184/tests/v8_7/run.html) 19:56:42 INFO - 2015-12-02 19:56:42,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 442408960 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: |0;Richards;165.72754391779912 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.01190476190476 19:56:42 INFO - 2015-12-02 19:56:42,523 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 19:56:42 INFO - 2015-12-02 19:56:42,524 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 19:56:42 INFO - 2015-12-02 19:56:42,524 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2051.2295081967213 19:56:42 INFO - 2015-12-02 19:56:42,524 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 19:56:42 INFO - 2015-12-02 19:56:42,524 DEBUG : BROWSER_OUTPUT: |6;Boyer;12047.619047619048 19:56:42 INFO - 2015-12-02 19:56:42,524 DEBUG : BROWSER_OUTPUT: |7;RegExp;26552.63157894737 19:56:42 INFO - 2015-12-02 19:56:42,524 DEBUG : BROWSER_OUTPUT: |8;Splay;595.6316410861865 19:56:42 INFO - 2015-12-02 19:56:42,524 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: __startTimestamp1449115002521__endTimestamp 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,525 DEBUG : BROWSER_OUTPUT: Values: 165.7 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.01 Median:186.01 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: Values: 186.0 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: Values: 277.9 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: Values: 5181.3 19:56:42 INFO - 2015-12-02 19:56:42,526 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,527 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2051.23 Median:2051.23 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,527 DEBUG : BROWSER_OUTPUT: Values: 2051.2 19:56:42 INFO - 2015-12-02 19:56:42,527 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,527 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,527 DEBUG : BROWSER_OUTPUT: Values: 781.9 19:56:42 INFO - 2015-12-02 19:56:42,527 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,527 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,528 DEBUG : BROWSER_OUTPUT: Values: 12047.6 19:56:42 INFO - 2015-12-02 19:56:42,528 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,528 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,528 DEBUG : BROWSER_OUTPUT: Values: 26552.6 19:56:42 INFO - 2015-12-02 19:56:42,528 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,529 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.63 Median:595.63 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,529 DEBUG : BROWSER_OUTPUT: Values: 595.6 19:56:42 INFO - 2015-12-02 19:56:42,529 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2015-12-02 19:56:42,529 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:56:42 INFO - 2015-12-02 19:56:42,529 DEBUG : BROWSER_OUTPUT: Values: 4835.7 19:56:42 INFO - 2015-12-02 19:56:42,529 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:56:42 INFO - 2015-12-02 19:56:42,529 DEBUG : BROWSER_OUTPUT: 19:56:43 INFO - 2015-12-02 19:56:43,497 INFO : Browser exited with error code: 0 19:56:43 INFO - 2015-12-02 19:56:43,512 INFO : Completed test v8_7 (00:00:39) 19:56:43 INFO - 2015-12-02 19:56:43,518 INFO : Completed test suite (00:20:17) 19:56:43 INFO - 2015-12-02 19:56:43,518 DEBUG : Working with test: dromaeo_css 19:56:43 INFO - 2015-12-02 19:56:43,518 DEBUG : Generating results file: dromaeo_css 19:56:43 INFO - 2015-12-02 19:56:43,519 DEBUG : Working with test: kraken 19:56:43 INFO - 2015-12-02 19:56:43,519 DEBUG : Generating results file: kraken 19:56:43 INFO - 2015-12-02 19:56:43,519 INFO : javascript benchmark 19:56:43 INFO - 2015-12-02 19:56:43,519 DEBUG : Working with test: v8_7 19:56:43 INFO - 2015-12-02 19:56:43,519 DEBUG : Generating results file: v8_7 19:56:43 INFO - 2015-12-02 19:56:43,519 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:56:43 INFO - 2015-12-02 19:56:43,572 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 19:56:43 INFO - 2015-12-02 19:56:43,573 DEBUG : process_Request line: dromaeo_css 6299.75 graph.html#tests=[[72,132,35]] 19:56:43 INFO - 2015-12-02 19:56:43,573 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:56:43 INFO - 2015-12-02 19:56:43,611 DEBUG : process_Request line: kraken 1520.90 graph.html#tests=[[232,132,35]] 19:56:43 INFO - 2015-12-02 19:56:43,612 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:56:43 INFO - 2015-12-02 19:56:43,650 DEBUG : process_Request line: v8_7 19848.67 graph.html#tests=[[230,132,35]] 19:56:43 INFO - 2015-12-02 19:56:43,651 INFO : javascript benchmark 19:56:43 INFO - 2015-12-02 19:56:43,655 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2607.973920260797, 2616.712161662218, 2617.2279177642604, 2631.3290111021697, 2638.6305917171594, 4563.133004729108, 4609.79255933483, 4612.8385506507275, 4626.329182268569, 4684.836030738925, 4609.308603709437, 4642.2804465307845, 4677.625789936806, 4713.198756211444, 4746.359241502396, 4095.9590404095875, 4334.0681753423005, 4342.5657434256555, 4374.693771436001, 4403.119376124771, 4402.185595664796, 4420.602145806877, 4436.711613745112, 4445.0443154721725, 4476.888077798065, 4154.293770059112, 4252.128313695716, 4252.851150209759, 4269.5516970718245, 4395.560443955611, 4291.7854107294825, 4295.0, 4299.78501074945, 4327.6105150536605, 4330.978345108286, 4273.423087883127, 4274.658027357804, 4277.187334406484, 4327.1345730853955, 4329.610335069859, 4443.4445694288215, 4562.178807814592, 4577.725336479822, 4595.862124136282, 4701.083288758693, 5044.344235249394, 5047.823326183566, 5069.569086627641, 5073.137566613685, 5115.053715062725, 5091.46539613339, 5093.821716239951, 5098.4136824265315, 5098.464661210556, 5106.0, 4529.433820772403, 4582.679212455096, 4643.419572553431, 4645.953540464619, 4719.5752382285755, 5150.304708864255, 5177.456367081402, 5178.663386879841, 5182.481751824863, 5183.611229157828, 4953.950460495421, 4955.281484184845, 4956.330895329156, 4958.528939750718, 4998.400191976913, 4864.586510146677, 4866.853994380174, 4972.8756781080765, 4975.228839529878, 4986.601071914238, 5024.6231532634465, 5038.0, 5043.52086551777, 5060.7722652480725, 5078.21287700407, 4971.4282857471135, 4974.850754477371, 4975.925361119586, 4977.452480227172, 5018.5985121190215, 4033.3143365627916, 4145.502539695256, 4193.161367726467, 4197.370394440797, 4236.301010333261, 3582.390993531106, 3634.491171236029, 3657.926841463156, 3671.394219953731, 3676.540432445944, 4378.824847006148, 4384.649228061748, 4386.605205531518, 4395.0, 4421.46942366918, 5082.0, 5086.9745651271505, 5089.185730283137, 5093.159628661229, 5129.64092513528, 4220.978895105505, 4278.764667943231, 4317.848875289413, 4320.1143765527995, 4321.719088259253, 4483.955160448354, 4495.4605447345875, 4502.527234640381, 4513.729176249435, 4528.977355113269, 4828.903421931542, 4829.082474330006, 4834.613230941586, 4838.516148385133, 4870.707757534417, 4806.519348065165, 4895.996320754308, 4899.632527560376, 5072.416672082758, 5081.085404627055, 4729.69256998294, 4800.591949684316, 4835.2505361669, 4837.032593481388, 4847.442544107332, 4959.578435832995, 4966.726830024239, 4969.105560999054, 4972.204447288416, 5015.799368025384, 4841.515848415131, 5036.748162591783, 5036.874078148076, 5049.343585333883, 5049.394072711299, 4773.0, 4848.393950756155, 4859.3682821233015, 4890.364252647133, 4892.535209155125, 4858.271259311132, 4900.705957642553, 4904.901901961869, 4912.238603016538, 4946.826861059845, 4669.369635099218, 4761.142994261067, 4775.092732380836, 4782.880427989328, 4825.469198388245, 4808.807647694053, 4848.151573474698, 4868.269759535956, 4884.462709102067, 4937.432195297587, 4791.257355109963, 4801.975990120027, 4806.951930480651, 4811.326414302071, 4836.564709176191], "unit": "ms", "name": "dojo.html", "value": 4600.61403955558}, {"lowerIsBetter": false, "replicates": [549.8508118033312, 557.5261028126091, 571.0520535910389, 573.3005733005733, 573.9684317362544, 27450.588241176374, 28008.439831203363, 28200.871965121423, 28225.576616350772, 35914.461283080775, 39921.201575968465, 40290.39564406529, 40302.59697403025, 40310.59689403105, 40443.59556404435, 7756.999999999985, 7875.779254215606, 7923.603819808986, 7931.762047138566, 7937.126916039231, 7131.8217044573785, 7338.229485903983, 7757.922420775804, 9980.550875210633, 10275.177985761158, 9949.0, 10059.497025148714, 10062.647807326744, 10066.0, 10067.345622534549, 7127.857442851114, 9795.363301385423, 9919.65281215154, 9923.305368624164, 9945.055219754111, 7028.121484814398, 9723.319367644268, 9980.401175929395, 9994.750131246705, 10000.94999525005, 33093.69063093695, 33449.16377090568, 33492.0, 33527.32945341079, 33529.161770955674, 2823.251838262862, 2848.2879280179955, 2948.012415840696, 3162.478191098489, 3355.5302257683943, 27646.723532764616, 27930.720692793016, 28204.43591128166, 28253.434931301257, 28330.575041374395, 3138.3723255349023, 3209.149575362531, 3227.8708851645906, 3254.267789747312, 3279.475283954556, 207995.0, 208738.0, 208962.0, 210346.0, 210522.99999999846, 49749.50250497521, 51344.0, 55455.72272138613, 55543.722281388335, 55573.444265557635, 58510.12234816481, 59448.70275648594, 59642.701786491656, 59652.70173649104, 59679.64484972107, 13500.122492037986, 13894.93052534751, 13897.444102235999, 13907.65230869216, 13925.442982280798, 10390.116840068678, 10482.161427085815, 10527.631532896312, 10533.052025317758, 10536.367817930948, 18805.529861753566, 19028.71456928147, 19075.332363367215, 19092.33176838804, 19118.522036949187, 7358.227386124487, 7574.3183113520045, 7701.537907725442, 7735.574543400055, 7745.186755390716, 875.6847534887436, 910.713125365521, 974.3569244298728, 988.1620186453191, 989.2827699917502, 25853.482930341663, 25869.23092285247, 26050.478990420466, 26210.73789262121, 26225.0, 955.5652178258875, 979.2313034268066, 1026.7535791410007, 1039.153090231459, 1084.8806631270554, 13119.606411807661, 13132.606021819362, 13300.933495332654, 13519.797203041962, 13528.797068043987, 315969.0, 317404.7816652858, 319821.0, 320268.0, 322639.0, 44390.77804610956, 45011.77494112574, 45106.548934510894, 45151.54848451539, 45210.0, 1211.4427363412929, 1226.5216565539447, 1238.3498663201892, 1244.4089057697702, 1251.1554700577074, 23998.280051598478, 25073.49853002966, 25266.494670106127, 25296.11463598839, 25306.493870122864, 37547.43678844765, 38115.61884381121, 38149.427758583086, 38215.80892095522, 38259.61740382672, 224756.0, 226708.0, 315988.30087743973, 321512.0, 323240.0, 28930.0, 28944.42111157807, 28969.420611588073, 28974.27564310909, 29377.0, 36750.0, 37666.623333766314, 37919.241615168095, 38176.42735358916, 38488.422673660476, 31117.96345637628, 31809.522857157623, 32232.35535289234, 32547.18632034218, 32618.0, 32394.83802580972, 32792.672073279915, 36788.264234715694, 38247.6175238244, 38280.42579361256, 32649.510257346636, 33138.33723325568, 33144.66855331416, 33165.0, 33201.169970750925, 31637.8418107908, 31862.840685796422, 34338.48492272568, 34608.65391346054, 34755.30489390148, 23278.185263515697, 23955.880220598785, 23977.52044959126, 24818.0, 26517.734822651528], "unit": "ms", "name": "ext.html", "value": 17157.20504190685}, {"lowerIsBetter": false, "replicates": [328.74686491401604, 329.6917382247597, 332.247459504223, 333.8380885270643, 334.5483597143856, 11907.7618447631, 12129.393530323492, 14712.632184195387, 15164.848351516495, 15902.363905443783, 11656.009239214676, 14280.214588197645, 14773.556793296191, 15312.0, 15312.69374612507, 4607.562281583261, 4610.216263235241, 4816.124328319444, 4823.614110871139, 4964.205727083668, 3550.5916819565823, 3633.7638053526434, 4902.338184345122, 4954.7522623868845, 5572.916406253909, 5646.971765141168, 5669.149627555879, 5677.9495793278165, 5681.857953551153, 5693.914591281134, 5283.207518872181, 5665.12190610456, 5768.451997060272, 5782.392848750905, 5783.450572195635, 5048.899022019576, 5050.39395272566, 5058.721770302632, 5064.670796398223, 5068.0, 18538.907305463385, 18562.814371856242, 18690.906545467322, 18696.90651546747, 19472.0, 1844.2807305151002, 1860.125740901774, 1866.2628261836635, 1956.8238858502802, 1992.372402693147, 12300.569480068154, 12385.637579866208, 12657.0, 12772.297523636196, 12809.0, 1717.8625709943299, 1754.7192449208064, 1771.5128339706555, 1779.661864245789, 1788.9910550447294, 49744.0, 50468.747656261854, 51218.7439062806, 52657.2101418479, 54702.17946730802, 9144.405613635092, 9501.334906556613, 9678.467684277291, 9680.419174849532, 9727.0, 12320.630381088582, 12334.629961101182, 12343.567975120828, 12345.0, 12374.938125309496, 6392.648404337806, 6406.807795766134, 6440.516961227833, 6520.967395162994, 6599.505037122235, 6088.4824789893355, 6111.8472038198515, 6170.167027451326, 6180.196574445294, 6186.0, 4050.10897602527, 4114.917701645951, 4116.444280022159, 4122.299209134454, 4142.357934520154, 1601.66365063338, 1622.6673531925926, 1652.6529428819842, 1727.9308827647005, 1772.7252275897256, 815.8572249856252, 845.6279237135764, 848.9108643592334, 866.5017614871474, 882.8278485695228, 15262.694746105015, 15684.294206760724, 15868.0, 16011.439599613957, 16088.678226435406, 840.4663038970176, 848.321342925657, 850.991574983634, 858.8883445152215, 862.2239984014437, 8852.0, 9094.727158185266, 9132.3150763693, 9186.586603602855, 9198.540072996324, 460311.0, 460683.0, 463119.0, 465006.0, 465051.0, 66755.0, 68475.0, 69048.47612191012, 69074.0, 69831.3016869835, 1009.1018993096151, 1027.0, 1073.9892601073889, 1084.0677017764715, 1088.1403691083956, 13838.584842454742, 13874.722505550035, 14078.788818167532, 14347.713045739236, 14372.065815721944, 31996.84001579977, 32114.678853211168, 32224.516632250066, 32596.83701581477, 33000.33999319952, 41526.377104344065, 42291.36562951496, 42886.57113428826, 42997.35503967381, 44598.55401446074, 8843.778905527413, 8904.19862212404, 8945.19493245611, 9021.188093071654, 9022.639094436148, 15774.684506310039, 15852.841471585136, 16030.67938641244, 16212.918935405247, 16380.67238655244, 10518.684439466828, 10636.30863993838, 13263.270520121487, 13589.388477518733, 13655.385507651981, 12547.372631368578, 12734.61796146117, 12981.740365192833, 13024.8046279304, 13605.86394136046, 10067.546960386653, 10412.68761937143, 12083.577074802692, 13373.933130334286, 13379.464821407424, 8049.718259860877, 8373.204545568162, 8474.27968622674, 8485.236328730198, 9079.228265597498, 13190.934045329712, 13470.326483675974, 13743.381547830171, 13939.790903136663, 14210.786838197642], "unit": "ms", "name": "jquery.html", "value": 8162.999238166565}, {"lowerIsBetter": false, "replicates": [1221.200113925378, 1676.7987841459026, 1725.6376161006187, 1742.4162905426685, 1751.9562010949724, 6267.937320626792, 7073.257307982665, 7242.456815738814, 7253.601051942141, 7265.564066156027, 7097.041899343587, 7284.854302913952, 7285.41716662667, 7290.562566246029, 7298.744543940963, 1781.3052909365358, 1821.025751223096, 1822.6263615958696, 2070.9792902070976, 2115.481706981784, 1782.6434713057376, 1786.8927864328116, 1790.1407324484255, 2062.5153089024066, 2110.2930518276394, 2047.6928460730935, 2059.6292667319876, 2062.05145633009, 2063.3912995666315, 2063.4016135320812, 1991.1139542903413, 2045.0, 2047.672372420413, 2047.9692804607944, 2048.836093112555, 2074.8651337663155, 2094.4135642020105, 2095.434232757162, 2101.8949052547464, 2143.3248526714037, 7060.470464715167, 7110.075690160246, 7152.7496537621455, 7154.105736782903, 7164.426845852319, 4105.91788164238, 4163.604457576525, 4173.436586060873, 4176.979115104436, 4178.8328466861285, 2669.2526092694075, 2681.6647919010124, 2695.420484595821, 2713.4573085383004, 2744.7666948309416, 830.6137645994642, 843.9704610338608, 845.450457202823, 863.2921004776086, 1624.2771966474922, 9447.480388578626, 9546.331756777028, 9554.952225238829, 9574.952125239399, 9589.280803939733, 3677.9448308275396, 3704.4072948328676, 3801.8669346572738, 3867.9226415471535, 3878.3406820840523, 7828.45200835936, 7846.450748447668, 7858.960705196552, 7867.763967080997, 7868.44920855546, 4063.6342729154517, 4063.837446502107, 4074.1851629674184, 4113.938290925578, 4122.175564887035, 3762.3792074307435, 3799.544054713452, 3804.4673745675627, 3807.0862992881507, 3809.8666546670734, 3049.35963447674, 3057.7248047675816, 3097.535369694564, 3120.157557459473, 3126.1715645353997, 865.5628907401848, 874.61079819481, 886.3441053620274, 895.5880295064343, 944.9102335278137, 889.4574309671095, 922.1608336413831, 962.8892677342055, 965.3676841668719, 1014.2849291249652, 6658.201015878126, 6700.83247918806, 6711.865762684816, 6726.697298621574, 6733.696983635748, 544.104947361588, 706.6254884911006, 1096.6770684824994, 1129.5651174297955, 1145.616218566773, 5404.351477822608, 5428.995635807389, 5430.239766432703, 5452.6183167177915, 5456.072467680504, 8285.83428331442, 8498.0, 8622.439541429912, 8640.481571105754, 8681.262092722063, 8525.23272905429, 8630.223279904838, 8691.34814888886, 8694.26098781598, 8696.260817830429, 6574.934250657528, 6722.731090756315, 6763.5941843489545, 6800.761973331008, 6831.658417079127, 6756.763513277012, 6814.284500127415, 6816.2502124767225, 6824.897626535507, 6829.726810927507, 7498.775036748906, 7576.24237576238, 7736.419768517271, 7737.613119344122, 7762.0, 7724.729634462767, 7890.566018868788, 7909.090454597795, 7982.6008699565955, 7983.481073730189, 6222.377762223741, 6274.968625156845, 6340.651264180515, 6354.872902542016, 6369.45859601939, 6811.795646130624, 6882.174139103339, 6896.551724137915, 6907.6891539881835, 6924.723011079501, 5672.234248376416, 5742.425757424224, 6455.903161452676, 6472.126262954441, 6606.900896486461, 6360.4275615193, 6438.356164383524, 6468.611883287018, 6494.967525162344, 6561.409473147249, 6445.742170313135, 6475.805725828232, 6483.610983341015, 6507.837304067436, 6509.967450162719, 5402.945970540244, 5420.349558053059, 5420.4037555868035, 5421.024215641222, 5443.673379597237, 6134.907976380268, 6145.262568491809, 6148.938510614837, 6149.907751383822, 6166.845828854135], "unit": "ms", "name": "mootools.html", "value": 4034.851075142041}, {"lowerIsBetter": false, "replicates": [291.10485257832164, 298.1368936927595, 300.8360443558261, 302.9575859379686, 305.8333208401422, 5145.485451454852, 5265.631405801595, 5294.761735721892, 5304.761285742141, 5369.838904832852, 5134.563562097226, 5251.0, 5296.9735151324285, 5298.178782288742, 5301.6818990860575, 4085.0195952971294, 4086.346184610463, 4092.89767755807, 4095.0786073133604, 4095.672346212296, 3905.941410878839, 3991.042149884036, 4040.9797951010205, 4074.2055299216663, 4082.0, 4021.5174179098403, 4035.152617950234, 4035.919281614366, 4038.5355684096266, 4072.9185416291657, 4055.918881622366, 4067.8169482373364, 4070.959290407088, 4072.1652061327504, 4079.714419990602, 3549.4853246279145, 3552.0942159749097, 3553.6091029986683, 3557.2529768748595, 3565.1978304881195, 4970.925436118461, 5086.491350864921, 5119.923201151985, 5121.334226550562, 5169.767360468788, 4682.040181762764, 4683.133620280225, 4687.531246875285, 4691.530846915315, 4691.7332320273335, 5586.972065139689, 5594.776208951678, 5610.887782244373, 5611.046122159202, 5613.971930140364, 3630.618785027587, 3737.738358314919, 3738.065483629093, 3840.8655697050467, 3849.4610754494392, 5799.18811366409, 5846.035404158309, 5859.238299021143, 5860.4725574698905, 5864.53083753303, 3928.9981054830837, 3932.528096628423, 3936.3111455495173, 3947.3289540778137, 3948.1116748731306, 4011.7764081955283, 4013.2174226026227, 4014.759114453142, 4016.136530645925, 4020.557738648746, 4501.707389019703, 4565.794539245742, 4600.953990460052, 4608.377868987711, 4609.585137337589, 5544.556435485151, 5549.7780088796, 5554.444555544414, 5559.249501317351, 5562.749676264578, 1406.1000959386001, 1425.187643043476, 1427.3790900958115, 1427.964300892486, 1430.1633544376448, 949.7103383468109, 953.9189168920581, 959.1271942532402, 973.8101070291367, 974.1378879691382, 4922.360093187863, 4923.655344125877, 4923.926141107886, 4926.926096108561, 4928.831314221731, 5795.275590551181, 5806.129080637854, 5809.331926828384, 5812.709364531841, 5814.244148260699, 4921.0, 4924.72913989734, 4927.457979622239, 4928.556429921325, 4933.358663373739, 3060.540918862144, 3110.0669799060192, 3125.5780469636306, 3140.183552276379, 3141.104785136225, 5509.228707980886, 5511.5039646432015, 5514.283143191359, 5516.448355164532, 5518.751656175482, 5926.8814623707285, 5936.168936348915, 5939.227900372924, 5939.287285525765, 5947.256592925884, 5507.091329930597, 5508.944910550843, 5509.421510741315, 5513.641613295123, 5518.034343989705, 5600.60795744294, 5770.653760774367, 5775.306963164448, 5775.9133612995, 5785.9874521957645, 5450.345958485007, 5502.80740174092, 5580.190872323409, 5607.271054762855, 5623.971880140737, 5538.670719027324, 5545.667259964415, 5562.7774889005605, 5569.303837020372, 5577.609567330248, 3920.098377373163, 3920.5295364556437, 3920.7059470539252, 3921.0785465415033, 3926.862559810393, 5805.3033635962265, 5815.6219845711585, 5818.505427038749, 5826.504747096545, 5828.746819433842, 5458.0, 5624.465675760796, 5627.915581266366, 5630.296212973379, 5635.633683810539, 5622.0, 5630.0991841305195, 5630.18362337467, 5634.661920284796, 5638.182463542681, 5498.945010549844, 5499.450054994469, 5503.2020357048805, 5506.201600767786, 5515.669059856422, 5527.723613819373, 5646.689432081275, 5654.886902262014, 5659.292588426447, 5662.85842853932, 5486.231927530229, 5494.862628434321, 5495.258140151188, 5497.587680923867, 5502.174673798962], "unit": "ms", "name": "prototype.html", "value": 4176.351380882031}, {"lowerIsBetter": false, "replicates": [705.6224919667977, 785.9214078592138, 810.9513429194249, 811.2252798577359, 821.0475848016306, 10099.545520451578, 10207.897921020778, 10209.081182693575, 10230.0, 10233.692989210316, 10275.588976440951, 11560.537578496871, 11674.649760507198, 11718.062554995602, 11719.179657423983, 802.8434455281238, 816.8366326734647, 816.9591520423985, 817.8650522663753, 817.9141190175035, 803.6303300481785, 810.4245985350408, 810.5663470043528, 811.0186674124317, 812.0336799208952, 848.0671261612239, 856.1010938514565, 857.2284943550792, 857.3312816003527, 862.8619420892659, 852.5311078906576, 853.8420392227458, 853.9829203415928, 854.1671869926834, 854.5043874552775, 627.6767464755654, 633.072548716133, 633.8066889598671, 634.1945728924286, 634.4765568406037, 11917.106217033757, 11925.582604608884, 12032.39838008105, 12033.57882474118, 12066.034717222601, 11267.718307042307, 11328.0, 11330.773384532346, 11342.48958796848, 11485.196036277464, 9741.707748767478, 9770.755731106708, 9806.117449429586, 9893.604255829758, 9915.454649994248, 3273.8363081845814, 3287.0, 3315.088350703552, 3396.2188696599674, 3414.709749671281, 33387.16532086693, 34317.485237721456, 36218.818905905304, 37207.25585488275, 37475.25049499049, 8971.730848074569, 9023.503707296162, 9102.089791020977, 9206.677766278148, 9439.24486041115, 16319.592010199602, 16373.181340932906, 16498.25757840876, 16540.09029503365, 16541.917290413712, 6354.205724284465, 6371.299157092716, 6385.297617262097, 6477.740890364333, 6615.636140012345, 3598.586162591283, 3601.333753255656, 3611.7110631149444, 3622.8188590570367, 3657.762245454037, 2790.0, 2799.664040315175, 2810.0, 2819.718028197205, 2830.051932602601, 512.8000079968815, 517.5911030286107, 523.6308402576251, 528.3685995235656, 528.9576833853282, 487.36885732975884, 539.7490167072331, 587.5469913112737, 627.47737271067, 628.8742251549709, 7581.696732130763, 7777.105632852181, 7853.960730196312, 7896.842063158705, 7991.680332786624, 477.0816178855689, 494.3227777944239, 520.3313741841715, 536.9033573956725, 585.4906231578553, 3456.792592444461, 3592.6227746086806, 3603.189282411489, 3988.3618621020496, 4023.0, 48416.0, 48864.26703599449, 49320.260196097086, 49408.75295623571, 49433.50566494361, 42938.0, 42954.355684664755, 42978.355324670156, 43170.35244471335, 43619.34570981438, 36433.453498197545, 42742.0, 42885.571144288784, 42942.14115717668, 43403.56596434058, 7884.6057697113765, 8009.759707208793, 8218.260356567938, 8245.587720614065, 8469.449485783405, 31123.377532448772, 32191.0, 32336.514952275265, 32341.604131565848, 32391.51412728858, 38513.7327934415, 39848.402273966494, 40016.19967600574, 40091.1981760369, 42252.0, 8879.378443508893, 10123.0, 10204.744881378025, 10335.793284134124, 10549.997750213717, 11154.776904461703, 11300.0, 11368.204225704121, 11612.825807612724, 12015.158938874194, 10164.186865050926, 10310.690679279634, 10314.174866010851, 10770.407627580558, 10870.782584348426, 10917.890821092005, 10947.671569852917, 11015.118790496901, 11216.775664486502, 11381.829272560753, 10293.073623373932, 10312.690619281433, 10758.569657213624, 10960.342379457257, 11305.0, 9239.168474837297, 9293.117153870371, 9314.347995640512, 9504.762380940532, 9525.285603579621, 8692.217700406994, 9107.362484626012, 9182.17360437564, 9350.345475816628, 9504.382215155993], "unit": "ms", "name": "yui.html", "value": 5756.4938858155065}], "name": "dromaeo_css", "value": 6299.752744687284}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 111.0, 113.0, 112.0, 99.0, 110.0, 110.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 159.0, 176.0, 127.0, 155.0, 151.0, 139.0, 172.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 159.0, 161.0, 162.0, 163.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 83.0, 91.0, 72.0, 73.0, 73.0, 117.0, 86.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 131.0, 93.0, 95.0, 95.0, 130.0, 95.0, 95.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 73.0, 70.0, 70.0, 70.0, 70.0, 80.0, 68.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 70.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 84.0, 84.0, 81.0, 83.0, 85.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 126.0, 122.0, 127.0, 125.0, 126.0, 120.0, 120.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [153.0, 141.0, 147.0, 161.0, 149.0, 135.0, 163.0, 147.0, 146.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 70.0, 68.0, 69.0, 67.0, 72.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1520.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.72754391779912], "unit": "score", "name": "Richards", "value": 213.01226799999995}, {"lowerIsBetter": false, "replicates": [186.01190476190476], "unit": "score", "name": "DeltaBlue", "value": 355.4503679999999}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2051.2295081967213], "unit": "score", "name": "RayTrace", "value": 360.7538781218783}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [595.6316410861865], "unit": "score", "name": "Splay", "value": 136.81442418235883}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19848.672049893758}]} 19:56:43 INFO - RETURN: dromaeo_css: 6299.75 19:56:43 INFO - RETURN: kraken: 1520.90 19:56:43 INFO - RETURN: v8_7: 19848.67 19:56:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19848.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6299.75"}}} 19:56:43 INFO - Return code: 0 19:56:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:56:43 INFO - # TBPL SUCCESS # 19:56:43 INFO - Running post-action listener: _resource_record_post_action 19:56:43 INFO - Running post-run listener: _resource_record_post_run 19:56:44 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508440576; Read time: 8; Write time: 411772 19:56:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 230711296; Read time: 0; Write time: 280220 19:56:44 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276840448; Read time: 8; Write time: 131492 19:56:44 INFO - Running post-run listener: _upload_blobber_files 19:56:44 INFO - Blob upload gear active. 19:56:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:56:44 INFO - Copying logs to upload dir... 19:56:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.827301 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-02 19:56:44.476117) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:56:44.479803) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010006 build_url: 'https://queue.taskcluster.net/v1/task/VVpeySepQIGq6qnVX3NVRg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 19:56:44.531459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:56:44.531802) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1449112534.443290-1252779810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 19:56:44.581328) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 19:56:44.581656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 19:56:44.581945) ========= ========= Total master_lag: 0.23 =========