builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1452790609.89 results: success (0) buildid: 20160114080834 builduid: 06248de919ac455f930fa1e1caafa3ac revision: 556628e979a38beea2ef54edc5435fb0fc31439e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:49.892541) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:49.893252) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:49.893628) ========= 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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006364 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:49.941621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:49.941943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:49.990682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:49.990986) ========= 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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.045524) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.045865) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.046281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.046604) ========= 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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 08:56:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-14 08:56:51 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.495306 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.559874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.560411) ========= 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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018489 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.611192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:50.611552) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 556628e979a38beea2ef54edc5435fb0fc31439e --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 556628e979a38beea2ef54edc5435fb0fc31439e --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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 08:56:52,043 truncating revision to first 12 chars 2016-01-14 08:56:52,043 Setting DEBUG logging. 2016-01-14 08:56:52,043 attempt 1/10 2016-01-14 08:56:52,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/556628e979a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 08:56:52,283 unpacking tar archive at: fx-team-556628e979a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540643 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:51.167491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:51.167971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:51.215355) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:51.215861) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 08:56:51.216606) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-01-14 08:56:51.217159) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:56:52 INFO - MultiFileLogger online at 20160114 08:56:52 in /builds/slave/test 08:56:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:56:52 INFO - {'append_to_log': False, 08:56:52 INFO - 'base_work_dir': '/builds/slave/test', 08:56:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:56:52 INFO - 'branch': 'Fx-Team-Non-PGO', 08:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:56:52 INFO - 'config_files': ('talos/linux_config.py',), 08:56:52 INFO - 'default_actions': ('clobber', 08:56:52 INFO - 'read-buildbot-config', 08:56:52 INFO - 'download-and-extract', 08:56:52 INFO - 'populate-webroot', 08:56:52 INFO - 'create-virtualenv', 08:56:52 INFO - 'install', 08:56:52 INFO - 'run-tests'), 08:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:56:52 INFO - 'download_minidump_stackwalk': True, 08:56:52 INFO - 'download_symbols': 'ondemand', 08:56:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:56:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:56:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:56:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:56:52 INFO - 'installer_path': 'installer.exe', 08:56:52 INFO - 'log_level': 'info', 08:56:52 INFO - 'log_name': 'talos', 08:56:52 INFO - 'log_to_console': True, 08:56:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:56:52 INFO - 'opt_config_files': (), 08:56:52 INFO - 'pip_index': False, 08:56:52 INFO - 'sps_profile': False, 08:56:52 INFO - 'sps_profile_interval': 0, 08:56:52 INFO - 'suite': 'dromaeojs-e10s', 08:56:52 INFO - 'system_bits': '32', 08:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:56:52 INFO - 'title': 'talos-linux64-ix-065', 08:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:56:52 INFO - 'use_talos_json': True, 08:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:56:52 INFO - 'work_dir': 'build'} 08:56:52 INFO - ##### 08:56:52 INFO - ##### Running clobber step. 08:56:52 INFO - ##### 08:56:52 INFO - Running pre-action listener: _resource_record_pre_action 08:56:52 INFO - Running main action method: clobber 08:56:52 INFO - rmtree: /builds/slave/test/build 08:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:56:53 INFO - Running post-action listener: _resource_record_post_action 08:56:53 INFO - ##### 08:56:53 INFO - ##### Running read-buildbot-config step. 08:56:53 INFO - ##### 08:56:53 INFO - Running pre-action listener: _resource_record_pre_action 08:56:53 INFO - Running main action method: read_buildbot_config 08:56:53 INFO - Using buildbot properties: 08:56:53 INFO - { 08:56:53 INFO - "project": "", 08:56:53 INFO - "product": "firefox", 08:56:53 INFO - "script_repo_revision": "production", 08:56:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:56:53 INFO - "repository": "", 08:56:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:56:53 INFO - "buildid": "20160114080834", 08:56:53 INFO - "pgo_build": "False", 08:56:53 INFO - "basedir": "/builds/slave/test", 08:56:53 INFO - "buildnumber": 642, 08:56:53 INFO - "slavename": "talos-linux64-ix-065", 08:56:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:56:53 INFO - "platform": "ubuntu64_hw", 08:56:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:56:53 INFO - "branch": "fx-team", 08:56:53 INFO - "repo_path": "integration/fx-team", 08:56:53 INFO - "revision": "556628e979a38beea2ef54edc5435fb0fc31439e", 08:56:53 INFO - "stage_platform": "linux64", 08:56:53 INFO - "builduid": "06248de919ac455f930fa1e1caafa3ac", 08:56:53 INFO - "slavebuilddir": "test" 08:56:53 INFO - } 08:56:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:56:53 INFO - Running post-action listener: _resource_record_post_action 08:56:53 INFO - ##### 08:56:53 INFO - ##### Running download-and-extract step. 08:56:53 INFO - ##### 08:56:53 INFO - Running pre-action listener: _resource_record_pre_action 08:56:53 INFO - Running main action method: download_and_extract 08:56:53 INFO - mkdir: /builds/slave/test/build/tests 08:56:53 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')]} 08:56:53 INFO - https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/test_packages.json 08:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/test_packages.json 08:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:56:55 INFO - Downloaded 1448 bytes. 08:56:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:56:55 INFO - Using the following test package requirements: 08:56:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:56:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:56:55 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:56:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'jsshell-linux-x86_64.zip'], 08:56:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:56:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:56:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:56:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:56:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:56:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:56:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:56:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:56:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:56:55 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')]} 08:56:55 INFO - https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:56:58 INFO - Downloaded 21171007 bytes. 08:56:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:56:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:56:59 INFO - Return code: 0 08:56:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:56:59 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')]} 08:56:59 INFO - https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:57:04 INFO - Downloaded 21171007 bytes. 08:57:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:57:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:57:05 INFO - Return code: 0 08:57: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')]} 08:57:05 INFO - https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:57:07 INFO - Downloaded 11132144 bytes. 08:57:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:57:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:57:07 INFO - Return code: 0 08:57: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')]} 08:57:07 INFO - https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:57:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:57:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:57:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:57:30 INFO - Downloaded 54220085 bytes. 08:57:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:57:30 INFO - mkdir: /builds/slave/test/properties 08:57:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:57:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:57:30 INFO - Contents: 08:57:30 INFO - build_url:https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:57:30 INFO - Running post-action listener: _resource_record_post_action 08:57:30 INFO - Running post-action listener: set_extra_try_arguments 08:57:30 INFO - ##### 08:57:30 INFO - ##### Running populate-webroot step. 08:57:30 INFO - ##### 08:57:30 INFO - Running pre-action listener: _resource_record_pre_action 08:57:30 INFO - Running main action method: populate_webroot 08:57:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:57:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:57:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:57:30 INFO - '--tppagecycles', 08:57:30 INFO - '7'], 08:57:30 INFO - 'tests': ['tsvgm']}}, 08:57:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:57:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:57:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:57:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:57:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'tests': ['damp', 'tps']}, 08:57:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['damp', 'tps']}, 08:57:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:57:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:57:30 INFO - 'other': {'tests': ['a11yr', 08:57:30 INFO - 'ts_paint', 08:57:30 INFO - 'tpaint', 08:57:30 INFO - 'sessionrestore', 08:57:30 INFO - 'sessionrestore_no_auto_restore']}, 08:57:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['a11yr', 08:57:30 INFO - 'ts_paint', 08:57:30 INFO - 'tpaint', 08:57:30 INFO - 'sessionrestore', 08:57:30 INFO - 'sessionrestore_no_auto_restore']}, 08:57:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['a11yr', 08:57:30 INFO - 'ts_paint', 08:57:30 INFO - 'tpaint', 08:57:30 INFO - 'sessionrestore', 08:57:30 INFO - 'sessionrestore_no_auto_restore']}, 08:57:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['a11yr', 08:57:30 INFO - 'ts_paint', 08:57:30 INFO - 'tpaint', 08:57:30 INFO - 'sessionrestore', 08:57:30 INFO - 'sessionrestore_no_auto_restore']}, 08:57:30 INFO - 'other_l64': {'tests': ['a11yr', 08:57:30 INFO - 'ts_paint', 08:57:30 INFO - 'tpaint', 08:57:30 INFO - 'sessionrestore', 08:57:30 INFO - 'sessionrestore_no_auto_restore']}, 08:57:30 INFO - 'other_nol64': {'tests': ['a11yr', 08:57:30 INFO - 'ts_paint', 08:57:30 INFO - 'tpaint', 08:57:30 INFO - 'sessionrestore', 08:57:30 INFO - 'sessionrestore_no_auto_restore']}, 08:57:30 INFO - 'svgr': {'tests': ['tsvgx', 08:57:30 INFO - 'tsvgr_opacity', 08:57:30 INFO - 'tart', 08:57:30 INFO - 'tscrollx', 08:57:30 INFO - 'cart']}, 08:57:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['tsvgx', 08:57:30 INFO - 'tsvgr_opacity', 08:57:30 INFO - 'tart', 08:57:30 INFO - 'tscrollx', 08:57:30 INFO - 'cart']}, 08:57:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'tests': ['tp5o']}, 08:57:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'talos_options': ['--e10s'], 08:57:30 INFO - 'tests': ['tp5o']}, 08:57:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'talos_options': ['--xperf_path', 08:57:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:30 INFO - 'tests': ['tp5n']}, 08:57:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:57:30 INFO - 'talos_options': ['--e10s', 08:57:30 INFO - '--xperf_path', 08:57:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:30 INFO - 'tests': ['tp5n']}}, 08:57:30 INFO - 'talos.zip': {'path': '', 08:57:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:57:30 INFO - Running post-action listener: _resource_record_post_action 08:57:30 INFO - ##### 08:57:30 INFO - ##### Running create-virtualenv step. 08:57:30 INFO - ##### 08:57:30 INFO - Running pre-action listener: _resource_record_pre_action 08:57:30 INFO - Running main action method: create_virtualenv 08:57:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:57:30 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 08:57:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:57:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:57:30 INFO - Using real prefix '/usr' 08:57:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:57:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:57:32 INFO - Installing pip.................done. 08:57:32 INFO - Return code: 0 08:57:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:57:32 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')]} 08:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:32 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')]} 08:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:32 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:32 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 08:57:32 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 08:57:32 INFO - Using env: {'DISPLAY': ':0', 08:57:32 INFO - 'HOME': '/home/cltbld', 08:57:32 INFO - 'LANG': 'en_US.UTF-8', 08:57:32 INFO - 'LANGUAGE': 'en_US:en', 08:57:32 INFO - 'LOGNAME': 'cltbld', 08:57:32 INFO - 'MAIL': '/var/mail/cltbld', 08:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:32 INFO - 'MOZ_NO_REMOTE': '1', 08:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:32 INFO - 'NO_EM_RESTART': '1', 08:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:32 INFO - 'PWD': '/builds/slave/test', 08:57:32 INFO - 'SHELL': '/bin/bash', 08:57:32 INFO - 'SHLVL': '1', 08:57:32 INFO - 'TERM': 'linux', 08:57:32 INFO - 'TMOUT': '86400', 08:57:32 INFO - 'USER': 'cltbld', 08:57:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:32 INFO - '_': '/tools/buildbot/bin/python'} 08:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:32 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 08:57:32 INFO - Cleaning up... 08:57:32 INFO - Return code: 0 08:57:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:57:32 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')]} 08:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:32 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')]} 08:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:32 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:32 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 08:57:32 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 08:57:32 INFO - Using env: {'DISPLAY': ':0', 08:57:32 INFO - 'HOME': '/home/cltbld', 08:57:32 INFO - 'LANG': 'en_US.UTF-8', 08:57:32 INFO - 'LANGUAGE': 'en_US:en', 08:57:32 INFO - 'LOGNAME': 'cltbld', 08:57:32 INFO - 'MAIL': '/var/mail/cltbld', 08:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:32 INFO - 'MOZ_NO_REMOTE': '1', 08:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:32 INFO - 'NO_EM_RESTART': '1', 08:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:32 INFO - 'PWD': '/builds/slave/test', 08:57:32 INFO - 'SHELL': '/bin/bash', 08:57:32 INFO - 'SHLVL': '1', 08:57:32 INFO - 'TERM': 'linux', 08:57:32 INFO - 'TMOUT': '86400', 08:57:32 INFO - 'USER': 'cltbld', 08:57:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:32 INFO - '_': '/tools/buildbot/bin/python'} 08:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:33 INFO - Downloading/unpacking psutil>=0.7.1 08:57:33 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 08:57:33 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 08:57:33 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 08:57:33 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 08:57:33 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 08:57:33 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 08:57:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:57:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:57:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:34 INFO - Installing collected packages: psutil 08:57:34 INFO - Running setup.py install for psutil 08:57:35 INFO - building 'psutil._psutil_linux' extension 08:57:35 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 08:57:35 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 08:57:35 INFO - building 'psutil._psutil_posix' extension 08:57:35 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 08:57:35 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 08:57:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:35 INFO - Successfully installed psutil 08:57:35 INFO - Cleaning up... 08:57:35 INFO - Return code: 0 08:57:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:57:35 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')]} 08:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:35 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')]} 08:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:35 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:35 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 08:57:35 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 08:57:35 INFO - Using env: {'DISPLAY': ':0', 08:57:35 INFO - 'HOME': '/home/cltbld', 08:57:35 INFO - 'LANG': 'en_US.UTF-8', 08:57:35 INFO - 'LANGUAGE': 'en_US:en', 08:57:35 INFO - 'LOGNAME': 'cltbld', 08:57:35 INFO - 'MAIL': '/var/mail/cltbld', 08:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:35 INFO - 'MOZ_NO_REMOTE': '1', 08:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:35 INFO - 'NO_EM_RESTART': '1', 08:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:35 INFO - 'PWD': '/builds/slave/test', 08:57:35 INFO - 'SHELL': '/bin/bash', 08:57:35 INFO - 'SHLVL': '1', 08:57:35 INFO - 'TERM': 'linux', 08:57:35 INFO - 'TMOUT': '86400', 08:57:35 INFO - 'USER': 'cltbld', 08:57:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:35 INFO - '_': '/tools/buildbot/bin/python'} 08:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:57:35 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 08:57:35 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 08:57:35 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 08:57:35 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 08:57:35 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 08:57:35 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 08:57:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:57:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:57:37 INFO - Installing collected packages: mozsystemmonitor 08:57:37 INFO - Running setup.py install for mozsystemmonitor 08:57:37 INFO - Successfully installed mozsystemmonitor 08:57:37 INFO - Cleaning up... 08:57:37 INFO - Return code: 0 08:57:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:57:37 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')]} 08:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:37 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')]} 08:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:37 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:37 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 08:57:37 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 08:57:37 INFO - Using env: {'DISPLAY': ':0', 08:57:37 INFO - 'HOME': '/home/cltbld', 08:57:37 INFO - 'LANG': 'en_US.UTF-8', 08:57:37 INFO - 'LANGUAGE': 'en_US:en', 08:57:37 INFO - 'LOGNAME': 'cltbld', 08:57:37 INFO - 'MAIL': '/var/mail/cltbld', 08:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:37 INFO - 'MOZ_NO_REMOTE': '1', 08:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:37 INFO - 'NO_EM_RESTART': '1', 08:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:37 INFO - 'PWD': '/builds/slave/test', 08:57:37 INFO - 'SHELL': '/bin/bash', 08:57:37 INFO - 'SHLVL': '1', 08:57:37 INFO - 'TERM': 'linux', 08:57:37 INFO - 'TMOUT': '86400', 08:57:37 INFO - 'USER': 'cltbld', 08:57:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:37 INFO - '_': '/tools/buildbot/bin/python'} 08:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:57:37 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 08:57:37 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 08:57:37 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 08:57:37 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 08:57:37 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 08:57:37 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 08:57:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:57:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:57:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:57:39 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 08:57:39 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 08:57:39 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 08:57:39 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 08:57:39 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 08:57:39 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 08:57:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:57:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:57:40 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 08:57:40 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 08:57:40 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 08:57:40 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 08:57:40 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 08:57:40 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 08:57:40 INFO - Downloading docopt-0.6.1.tar.gz 08:57:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:57:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:57:40 INFO - Running setup.py install for blobuploader 08:57:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:57:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:57:40 INFO - Running setup.py install for requests 08:57:40 INFO - Running setup.py install for docopt 08:57:40 INFO - Successfully installed blobuploader requests docopt 08:57:40 INFO - Cleaning up... 08:57:40 INFO - Return code: 0 08:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:40 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')]} 08:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:40 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')]} 08:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:40 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:40 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 08:57:40 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 08:57:40 INFO - Using env: {'DISPLAY': ':0', 08:57:40 INFO - 'HOME': '/home/cltbld', 08:57:40 INFO - 'LANG': 'en_US.UTF-8', 08:57:40 INFO - 'LANGUAGE': 'en_US:en', 08:57:40 INFO - 'LOGNAME': 'cltbld', 08:57:40 INFO - 'MAIL': '/var/mail/cltbld', 08:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:40 INFO - 'MOZ_NO_REMOTE': '1', 08:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:40 INFO - 'NO_EM_RESTART': '1', 08:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:40 INFO - 'PWD': '/builds/slave/test', 08:57:40 INFO - 'SHELL': '/bin/bash', 08:57:40 INFO - 'SHLVL': '1', 08:57:40 INFO - 'TERM': 'linux', 08:57:40 INFO - 'TMOUT': '86400', 08:57:40 INFO - 'USER': 'cltbld', 08:57:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:40 INFO - '_': '/tools/buildbot/bin/python'} 08:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:41 INFO - Running setup.py (path:/tmp/pip-GWosbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:41 INFO - Running setup.py (path:/tmp/pip-UZ39eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:41 INFO - Running setup.py (path:/tmp/pip-m7dMyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:41 INFO - Running setup.py (path:/tmp/pip-HVKuRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:41 INFO - Running setup.py (path:/tmp/pip-QqjNFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:41 INFO - Running setup.py (path:/tmp/pip-1qKDQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:41 INFO - Running setup.py (path:/tmp/pip-pMMAhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:41 INFO - Running setup.py (path:/tmp/pip-B2plaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:41 INFO - Running setup.py (path:/tmp/pip-PQDwhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:41 INFO - Running setup.py (path:/tmp/pip-KBDv2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:41 INFO - Running setup.py (path:/tmp/pip-Ngkmgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:41 INFO - Running setup.py (path:/tmp/pip-iWg1zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:42 INFO - Running setup.py (path:/tmp/pip-nge3GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:42 INFO - Running setup.py (path:/tmp/pip-0Y6yZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:42 INFO - Running setup.py (path:/tmp/pip-EaOvvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:42 INFO - Running setup.py (path:/tmp/pip-fyYgxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:42 INFO - Running setup.py (path:/tmp/pip-Pqf_8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:57:42 INFO - Running setup.py install for manifestparser 08:57:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:57:42 INFO - Running setup.py install for mozcrash 08:57:42 INFO - Running setup.py install for mozdebug 08:57:42 INFO - Running setup.py install for mozdevice 08:57:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:57:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:57:42 INFO - Running setup.py install for mozfile 08:57:42 INFO - Running setup.py install for mozhttpd 08:57:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Running setup.py install for mozinfo 08:57:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Running setup.py install for mozInstall 08:57:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Running setup.py install for mozleak 08:57:43 INFO - Running setup.py install for mozlog 08:57:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Running setup.py install for moznetwork 08:57:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Running setup.py install for mozprocess 08:57:43 INFO - Running setup.py install for mozprofile 08:57:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Running setup.py install for mozrunner 08:57:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:43 INFO - Running setup.py install for mozscreenshot 08:57:43 INFO - Running setup.py install for moztest 08:57:44 INFO - Running setup.py install for mozversion 08:57:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:44 INFO - Cleaning up... 08:57:44 INFO - Return code: 0 08:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:44 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:44 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 08:57:44 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 08:57:44 INFO - Using env: {'DISPLAY': ':0', 08:57:44 INFO - 'HOME': '/home/cltbld', 08:57:44 INFO - 'LANG': 'en_US.UTF-8', 08:57:44 INFO - 'LANGUAGE': 'en_US:en', 08:57:44 INFO - 'LOGNAME': 'cltbld', 08:57:44 INFO - 'MAIL': '/var/mail/cltbld', 08:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:44 INFO - 'MOZ_NO_REMOTE': '1', 08:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:44 INFO - 'NO_EM_RESTART': '1', 08:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:44 INFO - 'PWD': '/builds/slave/test', 08:57:44 INFO - 'SHELL': '/bin/bash', 08:57:44 INFO - 'SHLVL': '1', 08:57:44 INFO - 'TERM': 'linux', 08:57:44 INFO - 'TMOUT': '86400', 08:57:44 INFO - 'USER': 'cltbld', 08:57:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:44 INFO - '_': '/tools/buildbot/bin/python'} 08:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:44 INFO - Running setup.py (path:/tmp/pip-GW5f9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:44 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:44 INFO - Running setup.py (path:/tmp/pip-hKwRbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:44 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:44 INFO - Running setup.py (path:/tmp/pip-Etzhkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:44 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:44 INFO - Running setup.py (path:/tmp/pip-atd5By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:44 INFO - Running setup.py (path:/tmp/pip-cd5fGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:44 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:44 INFO - Running setup.py (path:/tmp/pip-RDXpJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:44 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:44 INFO - Running setup.py (path:/tmp/pip-fM_dgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:44 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:44 INFO - Running setup.py (path:/tmp/pip-CFBPxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:44 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)) 08:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:44 INFO - Running setup.py (path:/tmp/pip-QQvPZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:45 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:45 INFO - Running setup.py (path:/tmp/pip-5Rre9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:45 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:45 INFO - Running setup.py (path:/tmp/pip-hEhwbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:45 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:45 INFO - Running setup.py (path:/tmp/pip-KYBRar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:45 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:45 INFO - Running setup.py (path:/tmp/pip-2XZfN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:45 INFO - Running setup.py (path:/tmp/pip-0mXAnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:45 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:45 INFO - Running setup.py (path:/tmp/pip-OxAQXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:45 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:45 INFO - Running setup.py (path:/tmp/pip-OqiKeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:45 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)) 08:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:45 INFO - Running setup.py (path:/tmp/pip-lO839f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:45 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)) 08:57:45 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)) 08:57:45 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)) 08:57:45 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)) 08:57:45 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:45 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:45 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 08:57:45 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 08:57:45 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 08:57:45 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 08:57:45 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 08:57:45 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 08:57:47 INFO - Downloading blessings-1.5.1.tar.gz 08:57:47 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 08:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:47 INFO - Installing collected packages: blessings 08:57:47 INFO - Running setup.py install for blessings 08:57:47 INFO - Successfully installed blessings 08:57:47 INFO - Cleaning up... 08:57:47 INFO - Return code: 0 08:57:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:47 INFO - Reading from file tmpfile_stdout 08:57:47 INFO - Current package versions: 08:57:47 INFO - argparse == 1.2.1 08:57:47 INFO - blessings == 1.5.1 08:57:47 INFO - blobuploader == 1.2.4 08:57:47 INFO - docopt == 0.6.1 08:57:47 INFO - manifestparser == 1.1 08:57:47 INFO - mozInstall == 1.12 08:57:47 INFO - mozcrash == 0.16 08:57:47 INFO - mozdebug == 0.1 08:57:47 INFO - mozdevice == 0.48 08:57:47 INFO - mozfile == 1.2 08:57:47 INFO - mozhttpd == 0.7 08:57:47 INFO - mozinfo == 0.9 08:57:47 INFO - mozleak == 0.1 08:57:47 INFO - mozlog == 3.1 08:57:47 INFO - moznetwork == 0.27 08:57:47 INFO - mozprocess == 0.22 08:57:47 INFO - mozprofile == 0.28 08:57:47 INFO - mozrunner == 6.11 08:57:47 INFO - mozscreenshot == 0.1 08:57:47 INFO - mozsystemmonitor == 0.0 08:57:47 INFO - moztest == 0.7 08:57:47 INFO - mozversion == 1.4 08:57:47 INFO - psutil == 3.1.1 08:57:47 INFO - requests == 1.2.3 08:57:47 INFO - wsgiref == 0.1.2 08:57:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:47 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')]} 08:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:47 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')]} 08:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:47 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:47 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 08:57:47 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 08:57:47 INFO - Using env: {'DISPLAY': ':0', 08:57:47 INFO - 'HOME': '/home/cltbld', 08:57:47 INFO - 'LANG': 'en_US.UTF-8', 08:57:47 INFO - 'LANGUAGE': 'en_US:en', 08:57:47 INFO - 'LOGNAME': 'cltbld', 08:57:47 INFO - 'MAIL': '/var/mail/cltbld', 08:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:47 INFO - 'MOZ_NO_REMOTE': '1', 08:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:47 INFO - 'NO_EM_RESTART': '1', 08:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:47 INFO - 'PWD': '/builds/slave/test', 08:57:47 INFO - 'SHELL': '/bin/bash', 08:57:47 INFO - 'SHLVL': '1', 08:57:47 INFO - 'TERM': 'linux', 08:57:47 INFO - 'TMOUT': '86400', 08:57:47 INFO - 'USER': 'cltbld', 08:57:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:47 INFO - '_': '/tools/buildbot/bin/python'} 08:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:57:48 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 2)) 08:57:48 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 3)) 08:57:48 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 4)) 08:57:48 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 5)) 08:57:48 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 6)) 08:57:48 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 7)) 08:57:48 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 8)) 08:57:48 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 9)) 08:57:48 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:57:48 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 4)) 08:57:48 INFO - Cleaning up... 08:57:48 INFO - Return code: 0 08:57:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:57:48 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')]} 08:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:48 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')]} 08:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:48 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 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57:48 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 08:57:48 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 08:57:48 INFO - Using env: {'DISPLAY': ':0', 08:57:48 INFO - 'HOME': '/home/cltbld', 08:57:48 INFO - 'LANG': 'en_US.UTF-8', 08:57:48 INFO - 'LANGUAGE': 'en_US:en', 08:57:48 INFO - 'LOGNAME': 'cltbld', 08:57:48 INFO - 'MAIL': '/var/mail/cltbld', 08:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:48 INFO - 'MOZ_NO_REMOTE': '1', 08:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:48 INFO - 'NO_EM_RESTART': '1', 08:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:48 INFO - 'PWD': '/builds/slave/test', 08:57:48 INFO - 'SHELL': '/bin/bash', 08:57:48 INFO - 'SHLVL': '1', 08:57:48 INFO - 'TERM': 'linux', 08:57:48 INFO - 'TMOUT': '86400', 08:57:48 INFO - 'USER': 'cltbld', 08:57:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:48 INFO - '_': '/tools/buildbot/bin/python'} 08:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:48 INFO - Downloading/unpacking jsonschema 08:57:48 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 08:57:48 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 08:57:48 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 08:57:48 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 08:57:48 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 08:57:48 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 08:57:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:57:50 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 08:57:50 INFO - Downloading/unpacking functools32 (from jsonschema) 08:57: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 08:57: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 08:57: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 08:57: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 08:57: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 08:57: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 08:57:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:57:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:57:50 INFO - warning: no files found matching '*.txt' 08:57:50 INFO - no previously-included directories found matching 'build' 08:57:50 INFO - no previously-included directories found matching 'dist' 08:57:50 INFO - no previously-included directories found matching '.git*' 08:57:50 INFO - Installing collected packages: jsonschema, functools32 08:57:50 INFO - Running setup.py install for functools32 08:57:50 INFO - warning: no files found matching '*.txt' 08:57:50 INFO - no previously-included directories found matching 'build' 08:57:50 INFO - no previously-included directories found matching 'dist' 08:57:50 INFO - no previously-included directories found matching '.git*' 08:57:50 INFO - Successfully installed jsonschema functools32 08:57:50 INFO - Cleaning up... 08:57:50 INFO - Return code: 0 08:57:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7bc3596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, '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': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', '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 08:57: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', 'flake8'] in /builds/slave/test/build 08:57: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 flake8 08:57:50 INFO - Using env: {'DISPLAY': ':0', 08:57:50 INFO - 'HOME': '/home/cltbld', 08:57:50 INFO - 'LANG': 'en_US.UTF-8', 08:57:50 INFO - 'LANGUAGE': 'en_US:en', 08:57:50 INFO - 'LOGNAME': 'cltbld', 08:57:50 INFO - 'MAIL': '/var/mail/cltbld', 08:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:50 INFO - 'MOZ_NO_REMOTE': '1', 08:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:50 INFO - 'NO_EM_RESTART': '1', 08:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:50 INFO - 'PWD': '/builds/slave/test', 08:57:50 INFO - 'SHELL': '/bin/bash', 08:57:50 INFO - 'SHLVL': '1', 08:57:50 INFO - 'TERM': 'linux', 08:57:50 INFO - 'TMOUT': '86400', 08:57:50 INFO - 'USER': 'cltbld', 08:57:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:50 INFO - '_': '/tools/buildbot/bin/python'} 08:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:50 INFO - Downloading/unpacking flake8 08:57: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 08:57: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 08:57: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 08:57: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 08:57: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 08:57: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 08:57:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:57:52 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 08:57:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:57:52 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 08:57:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:52 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 08:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:57:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:57:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:57:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:57:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:57:53 INFO - no previously-included directories found matching 'docs/_build' 08:57:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:57:53 INFO - Running setup.py install for pep8 08:57:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:57:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:57:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:57:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:57:53 INFO - no previously-included directories found matching 'docs/_build' 08:57:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:57:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:57:53 INFO - Cleaning up... 08:57:53 INFO - Return code: 0 08:57:53 INFO - Running post-action listener: _resource_record_post_action 08:57:53 INFO - Running post-action listener: _start_resource_monitoring 08:57:53 INFO - Starting resource monitoring. 08:57:53 INFO - ##### 08:57:53 INFO - ##### Running install step. 08:57:53 INFO - ##### 08:57:53 INFO - Running pre-action listener: _resource_record_pre_action 08:57:53 INFO - Running main action method: install 08:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:53 INFO - Reading from file tmpfile_stdout 08:57:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:57:53 INFO - Reading from file tmpfile_stdout 08:57:53 INFO - Output received: 08:57:53 INFO - Usage: mozinstall [options] installer 08:57:53 INFO - Options: 08:57:53 INFO - -h, --help show this help message and exit 08:57:53 INFO - -d DEST, --destination=DEST 08:57:53 INFO - Directory to install application into. [default: 08:57:53 INFO - "/builds/slave/test"] 08:57:53 INFO - --app=APP Application being installed. [default: firefox] 08:57:53 INFO - mkdir: /builds/slave/test/build/application 08:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:58:09 INFO - Reading from file tmpfile_stdout 08:58:09 INFO - Output received: 08:58:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:58:09 INFO - Running post-action listener: _resource_record_post_action 08:58:09 INFO - ##### 08:58:09 INFO - ##### Running run-tests step. 08:58:09 INFO - ##### 08:58:09 INFO - Running pre-action listener: _resource_record_pre_action 08:58:09 INFO - Running main action method: run_tests 08:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:58:09 INFO - Python 2.7.3 08:58:09 INFO - Return code: 0 08:58:09 INFO - grabbing minidump binary from tooltool 08:58:09 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')]} 08:58:09 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 0x20743d0>, '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 0x1fdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:58:09 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 08:58:09 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 08:58:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:58:09 INFO - Return code: 0 08:58:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:58:10 INFO - Return code: 0 08:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:58:10 INFO - Using env: {'DISPLAY': ':0', 08:58:10 INFO - 'HOME': '/home/cltbld', 08:58:10 INFO - 'LANG': 'en_US.UTF-8', 08:58:10 INFO - 'LANGUAGE': 'en_US:en', 08:58:10 INFO - 'LOGNAME': 'cltbld', 08:58:10 INFO - 'MAIL': '/var/mail/cltbld', 08:58:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:58:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:10 INFO - 'MOZ_NO_REMOTE': '1', 08:58:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:10 INFO - 'NO_EM_RESTART': '1', 08:58:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:10 INFO - 'PWD': '/builds/slave/test', 08:58:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:58:10 INFO - 'SHELL': '/bin/bash', 08:58:10 INFO - 'SHLVL': '1', 08:58:10 INFO - 'TERM': 'linux', 08:58:10 INFO - 'TMOUT': '86400', 08:58:10 INFO - 'USER': 'cltbld', 08:58:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021', 08:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:10 INFO - '_': '/tools/buildbot/bin/python'} 08:58:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:58:10 INFO - mozversion application_buildid: 20160114080834 08:58:10 INFO - mozversion application_changeset: 556628e979a38beea2ef54edc5435fb0fc31439e 08:58:10 INFO - mozversion application_display_name: Nightly 08:58:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:58:10 INFO - mozversion application_name: Firefox 08:58:10 INFO - mozversion application_remotingname: firefox 08:58:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:58:10 INFO - mozversion application_vendor: Mozilla 08:58:10 INFO - mozversion application_version: 46.0a1 08:58:10 INFO - mozversion platform_buildid: 20160114080834 08:58:10 INFO - mozversion platform_changeset: 556628e979a38beea2ef54edc5435fb0fc31439e 08:58:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:58:10 INFO - mozversion platform_version: 46.0a1 08:58:10 INFO - using testdate: 1452790690 08:58:10 INFO - actual date: 1452790690 08:58:10 INFO - starting webserver on 'localhost:60858' 08:58:10 INFO - SUITE-START | Running 3 tests 08:58:10 INFO - TEST-START | dromaeo_css 08:58:10 INFO - operating with platform_type : linux_ 08:58:10 INFO - Initialising browser for dromaeo_css test... 08:58:10 INFO - TEST-INFO | started process 3581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4BIvfK/profile http://localhost:60858/getInfo.html) 08:58:14 INFO - PROCESS | 3581 | 08:58:14 INFO - PROCESS | 3581 | (process:3663): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:58:15 INFO - PROCESS | 3581 | __metrics Screen width/height:1600/1200 08:58:15 INFO - PROCESS | 3581 | colorDepth:24 08:58:15 INFO - PROCESS | 3581 | Browser inner width/height: 1024/697 08:58:15 INFO - PROCESS | 3581 | __metrics 08:58:15 INFO - PROCESS | 3581 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:58:16 INFO - TEST-INFO | 3581: exit 0 08:58:16 INFO - Browser initialized. 08:58:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:58:16 INFO - TEST-INFO | started process 3712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4BIvfK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:18 INFO - PROCESS | 3712 | 08:58:18 INFO - PROCESS | 3712 | (process:3771): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:58:28 INFO - PROCESS | 3712 | RSS: Main: 150904832 08:58:28 INFO - PROCESS | 3712 | 08:59:18 INFO - PROCESS | 3712 | 1452790758467 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] 09:01:28 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60858/tests/dromaeo/cssquery-ext.html) 09:01:29 INFO - PROCESS | 3712 | RSS: Main: 153460736 09:01:29 INFO - PROCESS | 3712 | 09:04:31 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-ext.html (next: http://localhost:60858/tests/dromaeo/cssquery-jquery.html) 09:04:32 INFO - PROCESS | 3712 | RSS: Main: 152272896 09:04:32 INFO - PROCESS | 3712 | 09:07:33 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60858/tests/dromaeo/cssquery-mootools.html) 09:07:34 INFO - PROCESS | 3712 | RSS: Main: 152576000 09:07:34 INFO - PROCESS | 3712 | 09:10:36 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60858/tests/dromaeo/cssquery-prototype.html) 09:10:36 INFO - PROCESS | 3712 | RSS: Main: 150888448 09:10:36 INFO - PROCESS | 3712 | 09:13:39 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60858/tests/dromaeo/cssquery-yui.html) 09:13:40 INFO - PROCESS | 3712 | RSS: Main: 150986752 09:13:40 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:60858/tests/dromaeo/cssquery-yui.html (next: http://localhost:60858/tests/dromaeo/cssquery-dojo.html) 09:16:42 INFO - PROCESS | 3712 | RSS: Main: 152358912 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | __start_tp_report 09:16:42 INFO - PROCESS | 3712 | _x_x_mozilla_page_load 09:16:42 INFO - PROCESS | 3712 | _x_x_mozilla_page_load_details 09:16:42 INFO - PROCESS | 3712 | |i|pagename|runs| 09:16:42 INFO - PROCESS | 3712 | |0;dojo.html;2613.699424566175;2634.275574217091;2661.5342315094867;2668.4396276781886;2678.183154137988;4424.668149888755;4430.8449204277895;4451.332300154978;4451.710638808475;4479.216137175989;4477.417935668359;4488.775561221934;4492.124035813018;4537.546245375469;4555.5899969002785;41.448648278484434;4191.7694526801015;4216.0513884376;4233.724807887493;4289.227938970984;3977.602239776028;4180.5610410906875;4195.349720793267;4196.748195108304;4257.510386305568;4199.958000420018;4200.663946884257;4203.97898010511;4234.788260586974;4243.97878010611;4044.373122166069;4135.028268356934;4248.702590818644;4254.127903779718;4319.287317592593;4116.9794151029355;4203.201391735561;4243.278642630729;4253.723882835168;4298.075913678574;4415.2935530315;4443;4457.086297309076;4477.126960242754;4478.283474644074;4685.6485763567525;4773.546513081286;4848.151573474628;4854.150523658381;4855.344528488644;4823.397075365579;4829.3721816164025;4841.983183531463;4844.055409195208;4885.145099607555;4464.508904020555;4466.39703640011;4474.127545128668;4491.30384790358;4527.547245275512;4815.892344760725;4893.853184404474;4898.926516102261;4905.484924082992;4906.656534042583;4745.905081898342;4764.14245435818;4771;4771.33201351811;4812.181929072066;4848.5636292733825;4855.587275081587;4859.2954021667365;4864.100141473838;4899.559039686445;4666.580007799314;4716;4771.785269662873;4781.258904869751;4797.064572408347;4670.976645116821;4676.672632915731;4703;4726.621870250372;4755.215389460769;3931.2334094851803;3937.409388591734;3964.72246942717;3988.541317748438;3995.6403923647013;3459.4810778383444;3475.669811367916;3502.2470168913806;3528.7177025837873;3529.752917295816;4066;4069.2878746219294;4075.653569446571;4116.135611521554;4141.482314710661;4665.86002419928;4673.088747694167;4683.836065737751;4696.60078893291;4704.529547045268;4133.937990930139;4167.166566686675;4200.1179752251755;4219.451471308772;4240.554741752133;4218.535961044283;4255.085156691326;4263.062126332202;4279.122779830127;4279.614834664832;4478.596926276651;4532.1842068427995;4550.067236216568;4569.543045695404;4611.608013318905;4733.5266473352385;4734.431868175841;4776.761161941959;4778.689385189951;4825.324454576292;4531.660125490535;4551.112533056023;4573.176828170828;4573.428321459817;4617.8383756568355;4578.839740609063;4653.697509661861;4757.595604373529;4761.500042495627;4824.710517368969;4662.533746625446;4701.623870090453;4712.363830882924;4732.2428411454;4761.357216775829;4598.402207712976;4640.791164397678;4644.071185762793;4646.163690535736;4679.859604211879;4494.4606647202545;4566.1552612766745;4590.6557008223845;4626.86119416418;4637.304404339376;4584.679072464895;4596.080783843312;4625.213713668752;4625.7918393673035;4639.698419602715;4661.114388266218;4683.765811709332;4690.742009189527;4697.8355757548325;4700.012997270612;4448.35498852671;4455.888602784827;4525.343825145402;4527.298268768346;4552.817887284604 09:16:42 INFO - PROCESS | 3712 | |1;ext.html;493.56812788809793;521.2780299285488;536.5787856532622;542.7679168287987;552.3509875895822;31405;32241.35517289653;32301.51547726786;32308.192295192603;32344.67655323446;35421.11447213821;35863.10342241445;35903.4614480783;35908.82045589769;36038.09904752383;7623.69505219792;7794.64924078415;7817.140114587391;7818.804529886742;7860.331871790904;7578.393728501735;7661.118971318314;7664.961675191644;7898.723544675938;7908.367330613566;7884.172161923001;7931.325837303836;7962.084360298553;7972.3622110231045;7977.521348719067;7789.104253010892;7855;7885.211478852098;7901.525908445454;7917.722879699211;7832.882506762403;7952.284294413531;7968.60156992148;7971.72098976533;7996.760097197093;36386.27227455463;36810.63189368099;36870.8156459216;36911.26177476462;36912.07719807026;2400.3159099656514;2915.1691767846273;2944.2492164497917;3063.3107550801114;3081.8613162407523;23603.881980589988;28125.85937070322;28845;29883.551746723817;31405.84297078523;3390.6609339066144;3435.879744208941;3453;3487.6861082502696;3550.4496802995577;176613;176834.11582942132;177227;177459;177997;46193.53806461892;47134.29298560524;50355.24467132996;50726.49273507218;55523;48431.757841210565;48719;48891.75554122207;48914.75542622335;49000.509994900305;13420.261885596386;13553.322333883267;13685.11046781956;13692.726145477034;13706.65733356674;10679.946600266949;10738.892611073945;10745.194110441747;10772.569097236023;10781.460926953621;18498.445046648623;18794.530136746416;18840.717389239173;18859.3399231029;18888.81111188898;7078.362947334765;7258.600776957318;7264.745733899288;7298.598577078312;7310.96344518274;898.8247291778172;903.5798353765531;915.6520522201654;975.5756246032998;1082.4912291223113;26426.867865660934;26712.332191695365;26992;27047.594286085725;27265.45469090607;989.9059589339001;993.8012397520525;1003.5935446144323;1013.1540163963173;1051.5163025008583;14245.64385890361;15354.692906141814;15723.21383930799;15875.52373428799;16206.756898646294;298655;302488;302809;303205;303991;47035.76482117636;47385.28922066172;47649;47887.76056119697;47907.520924790304;1244.4524409260077;1249.1006475337742;1252.2298786246574;1256.0893352319679;1276.16411250631;25704.228873133838;26762.866185668947;26808.8659556701;27336.589951151145;27827.44345113127;38614.613853861105;39526;39609;39626.60373396229;39655.80172099121;233903;236814;237515;238053;238503;38148;38556.42165367578;38561.42157867578;38967.415488767125;39004;36488.27023459569;37747.245055098196;38021.619783801805;38265.04337391476;38364;31898.36203275968;32238.677613224507;32281.51577726289;32921.506177407835;33181.83409082939;32640.34719305553;32697.836510817295;35062.29875402529;36623.08442288964;36978;32605.836970814995;33116.1720956978;33186;33253.66746332506;33350.499742503394;30889.536656949713;32116.67883321137;32397.51403728993;32795.508067378534;32928.1767955803;26104;26198.90408767256;26512.867435662698;26516.734832651426;26572.33569160709 09:16:42 INFO - PROCESS | 3712 | |2;jquery.html;335.59895924370386;342.68175790775405;343.7799808122802;345.666431893223;352.22686203782706;13844.792328115074;14001.719965600681;14768.187749673763;15424.920255582085;15589;13812.654683632914;13928.791068133985;14781.187034713086;14840.109593424375;14856.702865942674;4505.864824055284;4555.977220113903;4653.27874179501;4658.045100754337;4927.778249978742;5025.321581586476;5046.293518907356;5049.823256186034;5069.340985671876;5069.797208111671;4950.306957026001;5294.364676238857;5296.073187192245;5298.576113910897;5318.946810531884;5179.067767801795;5218.13900706383;5283.365996080475;5295.417504074549;5801.53587712982;5117.66735162217;5125.3080834087295;5126.743662816844;5139.820106296299;5164.044651739403;11229.775404491946;15900.76148857768;17483;18163.184706370535;18200.1809918554;1838.3014454507336;1862.1713337564788;1865.4496923407628;1883.660941030614;1889.4520589029164;9069.455832650063;9229.676961306322;10627.309224900357;10788.676339709822;12148.5140594377;1716;1781.1094452773614;1784.9375271865551;1803.2877013579694;1815.5188874948017;47438.525614743754;48986.51013489855;49273;49283.50716492825;49309.50690493085;9379;9558.426494410358;9623.56693948774;9677.37097088687;9684.08001239881;12314.13801033919;12349.629511114681;12356.567520136932;12405.379731013594;12431.875681243253;6766.76316328936;6826.419754320839;6869.896951545731;6898.206706228848;7028.367446929801;6597.538172327891;6614.570052946543;6621.569597976116;6646.102776125258;6649.667516624149;3722.683571896419;3906.1015966327336;3961.3859851723028;4115.094679170577;4134.069834287321;1669.1654172913543;1798.6582549315588;1802.648483545696;1814.2833580735798;1824.206470185447;815.514768712615;848.5799529233069;854.3293514591016;875.5709702245854;1013.8732658417698;13838.15916775556;13868.514601988882;14170.574882753534;14267;14595.85404145945;826.5867066466767;827.4580150001758;855.0167307596314;864.6973559254336;961.2022021721954;6776.42400395962;8099.190080991853;8245.422820402635;8283.710070147516;8344.457610255315;403302;406168;414555;432220;433684;36488.635113648525;36662.26675466476;53442.465575344526;60006.099908501405;61766.0735088974;1092.3118435385657;1094.8521949536869;1101.388729255271;1107;1109.5949978258038;12579.119461637598;12751.93624031911;12771.169873958162;12877.549285774952;12973.675658108623;26250.474990500465;26921.192364229104;27068.45863082688;27540.173794786187;28326.15021549357;39396.60603394044;39652.603473966046;39720.404193936534;39743.80128099341;40098.59901401065;6775.695093720696;6780.25417204117;6895.931040689529;6907.758228461979;6991.720331186695;9285.164335209864;9397.953010234905;9871.802563948824;9934.105930466292;9980.451075190644;8498.787530311793;8710.346723995599;8980.191782739323;8982.146696063863;9019.729408117766;8827.337949653931;8991.460512369278;9086.22767064807;9509.334346595671;9668.70993870185;8317.500949943023;8627.525486098324;8647.048824629412;8684.39209255346;8888.288936884905;6661.600303981777;6721.462283017249;6886.793396198122;6908.032875397549;6936.445084393337;8277.875831862648;8789.42868713557;8943.597538110931;8955.507447090473;9073.727788166365 09:16:42 INFO - PROCESS | 3712 | |3;mootools.html;1383.626420866366;1403.6911879386532;1530.31135988805;1700.6938751024811;1735.869809764268;5871.588988770788;5952.136940143677;6855.79432617021;7027.367536921676;7062.823429414268;6406.167198264231;6527.184101987252;6562.8031159065185;6571.277159512461;6605.339466053392;2072.8134467897885;2097.622427962966;2105.0842883345717;2110.89445527723;2111.282164064218;2066.2354928676336;2070.4720296324417;2139.3474990128007;2173.315405647224;2175.042981088324;2100.905459254337;2112.7464704235513;2118.8199003084756;2131.4990977120365;2144.5925274197853;2075.6056349293585;2078.7193728846564;2105.631514484967;2109.1141720477435;2110.757262914761;1966.9213231470724;1980.6731889238258;1980.8811471311767;1983.7917018712972;1984.0972357577268;6983.9873218383555;6995.230524642286;7028.226895041541;7030.050943122716;7035.1557813062245;4117.382392641098;4192.643625291854;4192.895177620553;4201.936970945439;4203.91592168155;2629.250663560876;2677.6920654124638;2702;2708.91873243803;2730.945381092387;880.1022956584249;884.3146561414891;894.217559635319;908.5184852028435;931.4364809290417;9172.08279172084;9305.860412093823;9342.299327550392;9354.06459354066;9400;3809.142942837839;3833.616638336144;3838.1172330363615;3859.3824988001784;3909.100906791397;8334.49993000422;8359.205875441823;8360.749177524684;8371.874421883676;8382.371322150862;4172.165566886635;4172.749635021908;4194.0563373240775;4216.051388437577;4216.072464057902;3251.4635085210675;3339.532465454838;3690.1881586051027;3796.924061518754;3807.961920380816;3363.142398688368;3392.9491057634154;3404.455287154093;3427.3488037272837;3436.5876094868277;1075.5482697267166;1080.7028067281403;1105.7401510644993;1114.3146964616865;1115.726646971481;1186.4601606269127;1194.3132698698282;1203.3201241298639;1208.6796998795326;1223.2966044524435;6577.967110164419;6588.604683718992;6600.80197594073;6647.268800432045;6722.092517510074;409.6313318013752;414.52122798168165;414.65583565640446;417.5177669791396;422.1430496092936;5033.597312215087;5103.8724031898755;5107.208382700687;5109.514596113363;5120.513551212629;7881.054273487218;8007.239312265326;8181.304589109992;8435.70475033383;8473.915260847436;7714.228577142241;7796.064472263365;7892.368610511146;7901.249381308767;7948.841023179504;6496.805095847132;6653.567518111404;6713.462922966249;6726.7981960541265;6728.158980127484;6492.415682588401;6555.049517819794;6569.835754106186;6585;6595.835104122243;6914.135733033371;6974.4769142315545;7089.7873063808165;7463.738769143054;7466.104067511933;6922.584644921119;7043.295670432915;7098.148222213367;7184.856302873809;7187.460940429384;5148.176291793295;5322.813701520428;5947.494462970523;5975.641461512323;5991.310999234969;6369.49044076482;6376.330485298977;6398.0083087121575;6419.101325814483;6422.486201103994;5977.880442391041;6155.415235552616;6235.781747638811;6236.251649802053;6395.296517383177;6002.849928751816;6124.6325220486915;6124.816255512342;6216.502679785697;6230.844228894314;6199.194104766351;6316.589421687576;6323.968380158254;6336.809895703136;6345.682715864096;5671.858203544779;5692.459216374438;5712.742926568398;5720.342160651412;5736.885262294814;5628.240187574625;5630.071038278638;5635.9436405635415;5677.943220567741;5814.476697097281 09:16:42 INFO - PROCESS | 3712 | |4;prototype.html;312.18363978197016;319.86885376995434;322.7305200157868;328.1369996908131;328.4908391992411;5446.4281250468675;5466.972665136669;5539.584531160164;5563.972180139103;5592.664440133595;5435.157550579666;5508.3114610673665;5532.087205611069;5546.334439867212;5549.972250138743;4140.378943158536;4236;4241.957580424202;4246.193223287565;4250.787460626956;4230.090530535934;4240.448741663595;4245.193413251488;4253.085586598881;4270.701050926421;4206.8737937861915;4222.282212023963;4227.894302642443;4249.787510624472;4255.63827074699;4250.851220207278;4257.127288905783;4260;4265.104328091104;4265.936010959838;3551.1122219445137;3624.3476174288617;3725.608811074825;3734.047817806442;3734.663880250763;5206.895862082775;5290.444503327134;5332;5343.385510666284;5345.572354211654;4842.539958703917;4842.709437433765;4844;4844.927326090112;4848.466668666444;5805.042168042268;5812.157237200625;5813.505852002585;5818.1272809078555;5826.067829147316;3876.8061596920325;3951.269015232191;3952.229315283521;4015.5984401559904;4032.5362583303004;5966.642001479881;6070.544709146788;6081.17904082952;6081.5742897996715;6084.634921904656;4120.62914337711;4125.711200215956;4127.112670775798;4133.545310015956;4143.834246630101;4211.620954114144;4213.852515161954;4217.62041416274;4221.6200541951375;4222.071144348239;4711.128441238382;4779.976100119547;4803.879903002453;4831.565159135695;4833.637477189225;5771;5776.364599894008;5789.710514474259;5790.334111577138;5794.072948328248;1479.112532480503;1488.4567132996378;1489.8510148985015;1502.361496364041;1502.8422015688195;996.3772642098688;1003.5433877585826;1008.495752123938;1017.5675337981477;1022.5347466902541;5044.722540260247;5054.292399064134;5056.721880296545;5056.9494305057215;5061.417936937226;5960.195373624592;5983.102534619842;6005.369436209223;6021.608595441282;6023.307319658208;5042.168042273057;5044.772985215674;5057.089723849669;5063.544281014726;5074.771635276422;3162.8418579070953;3208.727258183034;3231.2406584452633;3244.3186930744337;3259.7392208623255;5438.238646589481;5565.526930210896;5613.775448981995;5615.831525054255;5644.153376993484;6063.120847477091;6229;6229.221347331583;6242.65665388408;6262.5929314594405;5626.465485778845;5673.517750991047;5674.546036317085;5676.801311954062;5678.375378708339;5814.418558144152;6048.0625503047095;6056.939430605637;6067.514598832171;6078.939210607838;5908.231929849092;5909.3795151508475;5911.527077833849;5916.940830591639;5922.2597175353085;5632.211490391431;5645.125005624135;5647.774089036557;5648.039833228278;5667.40492248308;4088.529819070726;4090.4068910008477;4090.9795451022555;4100.425940368411;4103.117829666636;5912.083627037816;6025.457708806229;6050.757969681339;6060.6666633333825;6064.211652485149;5828.358880523054;5837.036888913452;5870.823875283749;5871.530277577698;5881.206037184926;5778.56660750437;5802.4197580241635;5816.534677225727;5821.679807610452;5824;5564.7575334263975;5660.179274005329;5711.8857622848145;5713.085906254979;5716.828495145152;5833.883322333614;5879.617824841372;5887.793927212527;5894.440028197314;5903.085021821625;5679.17651940458;5681.062624667049;5685.147227915846;5690.402507736628;5693.975084484832 09:16:42 INFO - PROCESS | 3712 | |5;yui.html;688.4733179117974;776.646625785267;794.122494643419;797.9082405523363;804.2962407893093;11622;11708.707282317946;11720.648380548586;11735.354555499443;11770.764584708311;11580.65258042258;11609.361485118316;12714.68213294668;12973.027022973267;12985;773.404478551515;773.5010917957914;783.248081841433;783.4633276205789;786.6931896560318;791.2325044706625;791.7426836278232;794.3962588432775;795.2564352330561;795.4352409789028;821.0885916632533;821.4906757810136;822.7243873302451;825.405707890318;826.1738261738262;811.7848770075934;815.1033862750986;815.3599424451777;815.5106935838479;816.9387295952768;604.2115039872964;606.1453350775386;606.7542645228646;607.8571535689109;608.7595399817092;12208.389580520938;12264.877351226552;12270.570530031495;12280.815787763191;12298.139130260884;11076.39079850608;11348.205625606211;11457.36984465854;11509.884901151048;11652.825207621892;9185.816283674356;9295.72112836616;9306.581203845843;9336.90663093374;9364.204042656382;3175.3173067790535;3242.1732458223237;3254.2027203335333;3271.9345613087844;3287.096048586634;38058.61941380578;38109.428358574645;38458.42312365317;38617;38737.22525549502;8785.560721963877;8826.205641492297;9175.357724959189;9236.261099112055;9259.120383563552;15570.299336529883;15575.922120389325;15600.531984040497;15624.843751562566;15655.512726291212;6381.202349706286;6393.392627700361;6411.711472983727;6526.477881769447;6638.336166383419;3655.990072611459;3715.498407714978;3733.8693145739767;3800.7719536827326;3874;2547.197632745679;2566.6535017772735;2571.3314538219824;2580.729023452548;2590.2099859542645;450.49994506098204;452.16575418353085;461.3448902558375;473.9502352253033;475.7217028038567;567;574.3567204730729;597.3280059932575;599.7960693364278;608.191105829246;7484.775456736306;8247.092819789817;8421.747347579583;8601.61292741828;8631.827363452821;525.8974499972545;563.9492445679908;578.1587789765881;615.741388616782;633.4227772845674;3607.440846668718;3609.729270304738;3665.3585622515952;3856.4986551748652;3860.613938606173;43340.78329608395;43402.782986084865;43459.13081738348;43570.346444803356;43693;40584.39123413092;40899.591004089576;40910.79544602258;41246.793766030976;41302;36512.45231321586;36527.4520882187;37101.814490927914;37613.247735045145;37819.81090094587;7069.646517673993;7125.251848556034;7279.4540409468445;7418.591977441292;7573.507721998052;27817.721822781514;27847.86076069607;27957;28058.43883122285;28529.28676783097;32100.197495061875;32184.35631287408;32458.513122303655;35844.64155358413;36656.81671591625;9141.954290228507;9488.715338539854;9544.809103817746;9746.610135594497;9952.203823694232;10179.338343007681;10327.793444130924;10393.324433911772;10402.063814256451;11128.1653875958;9869.506524673881;10171.38971661673;10246.333988290737;10293.53679084428;11044.171687123659;9853.950730246303;9869.555869985725;10038.598456061676;10078.697639070839;10225.948870255601;10797.190210734068;10797.892021080002;10835.133189344991;10954.835677464685;11108.944455277671;8521.275691566287;8909.33807382603;8982.955085224532;9059.637614495346;9099.590518426554;8499.362547808816;8721.171488708562;8837.734867953972;8876.733697989072;9267.860982085409 09:16:42 INFO - PROCESS | 3712 | __end_tp_report 09:16:42 INFO - PROCESS | 3712 | __start_cc_report 09:16:42 INFO - PROCESS | 3712 | _x_x_mozilla_cycle_collect,342 09:16:42 INFO - PROCESS | 3712 | __end_cc_report 09:16:42 INFO - PROCESS | 3712 | __startTimestamp1452791802790__endTimestamp 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | ------- Summary: start ------- 09:16:42 INFO - PROCESS | 3712 | Number of tests: 6 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | [#0] dojo.html Cycles:165 Average:4406.21 Median:4550.07 stddev:556.15 (12.2%) stddev-sans-first:539.79 09:16:42 INFO - PROCESS | 3712 | Values: 2613.7 2634.3 2661.5 2668.4 2678.2 4424.7 4430.8 4451.3 4451.7 4479.2 4477.4 4488.8 4492.1 4537.5 4555.6 41.4 4191.8 4216.1 4233.7 4289.2 3977.6 4180.6 4195.3 4196.7 4257.5 4200.0 4200.7 4204.0 4234.8 4244.0 4044.4 4135.0 4248.7 4254.1 4319.3 4117.0 4203.2 4243.3 4253.7 4298.1 4415.3 4443.0 4457.1 4477.1 4478.3 4685.6 4773.5 4848.2 4854.2 4855.3 4823.4 4829.4 4842.0 4844.1 4885.1 4464.5 4466.4 4474.1 4491.3 4527.5 4815.9 4893.9 4898.9 4905.5 4906.7 4745.9 4764.1 4771.0 4771.3 4812.2 4848.6 4855.6 4859.3 4864.1 4899.6 4666.6 4716.0 4771.8 4781.3 4797.1 4671.0 4676.7 4703.0 4726.6 4755.2 3931.2 3937.4 3964.7 3988.5 3995.6 3459.5 3475.7 3502.2 3528.7 3529.8 4066.0 4069.3 4075.7 4116.1 4141.5 4665.9 4673.1 4683.8 4696.6 4704.5 4133.9 4167.2 4200.1 4219.5 4240.6 4218.5 4255.1 4263.1 4279.1 4279.6 4478.6 4532.2 4550.1 4569.5 4611.6 4733.5 4734.4 4776.8 4778.7 4825.3 4531.7 4551.1 4573.2 4573.4 4617.8 4578.8 4653.7 4757.6 4761.5 4824.7 4662.5 4701.6 4712.4 4732.2 4761.4 4598.4 4640.8 4644.1 4646.2 4679.9 4494.5 4566.2 4590.7 4626.9 4637.3 4584.7 4596.1 4625.2 4625.8 4639.7 4661.1 4683.8 4690.7 4697.8 4700.0 4448.4 4455.9 4525.3 4527.3 4552.8 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | [#1] ext.html Cycles:180 Average:39992.19 Median:18370.58 stddev:63699.86 (346.7%) stddev-sans-first:63809.52 09:16:42 INFO - PROCESS | 3712 | Values: 493.6 521.3 536.6 542.8 552.4 31405.0 32241.4 32301.5 32308.2 32344.7 35421.1 35863.1 35903.5 35908.8 36038.1 7623.7 7794.6 7817.1 7818.8 7860.3 7578.4 7661.1 7665.0 7898.7 7908.4 7884.2 7931.3 7962.1 7972.4 7977.5 7789.1 7855.0 7885.2 7901.5 7917.7 7832.9 7952.3 7968.6 7971.7 7996.8 36386.3 36810.6 36870.8 36911.3 36912.1 2400.3 2915.2 2944.2 3063.3 3081.9 23603.9 28125.9 28845.0 29883.6 31405.8 3390.7 3435.9 3453.0 3487.7 3550.4 176613.0 176834.1 177227.0 177459.0 177997.0 46193.5 47134.3 50355.2 50726.5 55523.0 48431.8 48719.0 48891.8 48914.8 49000.5 13420.3 13553.3 13685.1 13692.7 13706.7 10679.9 10738.9 10745.2 10772.6 10781.5 18498.4 18794.5 18840.7 18859.3 18888.8 7078.4 7258.6 7264.7 7298.6 7311.0 898.8 903.6 915.7 975.6 1082.5 26426.9 26712.3 26992.0 27047.6 27265.5 989.9 993.8 1003.6 1013.2 1051.5 14245.6 15354.7 15723.2 15875.5 16206.8 298655.0 302488.0 302809.0 303205.0 303991.0 47035.8 47385.3 47649.0 47887.8 47907.5 1244.5 1249.1 1252.2 1256.1 1276.2 25704.2 26762.9 26808.9 27336.6 27827.4 38614.6 39526.0 39609.0 39626.6 39655.8 233903.0 236814.0 237515.0 238053.0 238503.0 38148.0 38556.4 38561.4 38967.4 39004.0 36488.3 37747.2 38021.6 38265.0 38364.0 31898.4 32238.7 32281.5 32921.5 33181.8 32640.3 32697.8 35062.3 36623.1 36978.0 32605.8 33116.2 33186.0 33253.7 33350.5 30889.5 32116.7 32397.5 32795.5 32928.2 26104.0 26198.9 26512.9 26516.7 26572.3 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | [#2] jquery.html Cycles:180 Average:22401.53 Median:27129.91 stddev:68163.31 (251.2%) stddev-sans-first:68334.39 09:16:42 INFO - PROCESS | 3712 | Values: 335.6 342.7 343.8 345.7 352.2 13844.8 14001.7 14768.2 15424.9 15589.0 13812.7 13928.8 14781.2 14840.1 14856.7 4505.9 4556.0 4653.3 4658.0 4927.8 5025.3 5046.3 5049.8 5069.3 5069.8 4950.3 5294.4 5296.1 5298.6 5318.9 5179.1 5218.1 5283.4 5295.4 5801.5 5117.7 5125.3 5126.7 5139.8 5164.0 11229.8 15900.8 17483.0 18163.2 18200.2 1838.3 1862.2 1865.4 1883.7 1889.5 9069.5 9229.7 10627.3 10788.7 12148.5 1716.0 1781.1 1784.9 1803.3 1815.5 47438.5 48986.5 49273.0 49283.5 49309.5 9379.0 9558.4 9623.6 9677.4 9684.1 12314.1 12349.6 12356.6 12405.4 12431.9 6766.8 6826.4 6869.9 6898.2 7028.4 6597.5 6614.6 6621.6 6646.1 6649.7 3722.7 3906.1 3961.4 4115.1 4134.1 1669.2 1798.7 1802.6 1814.3 1824.2 815.5 848.6 854.3 875.6 1013.9 13838.2 13868.5 14170.6 14267.0 14595.9 826.6 827.5 855.0 864.7 961.2 6776.4 8099.2 8245.4 8283.7 8344.5 403302.0 406168.0 414555.0 432220.0 433684.0 36488.6 36662.3 53442.5 60006.1 61766.1 1092.3 1094.9 1101.4 1107.0 1109.6 12579.1 12751.9 12771.2 12877.5 12973.7 26250.5 26921.2 27068.5 27540.2 28326.2 39396.6 39652.6 39720.4 39743.8 40098.6 6775.7 6780.3 6895.9 6907.8 6991.7 9285.2 9398.0 9871.8 9934.1 9980.5 8498.8 8710.3 8980.2 8982.1 9019.7 8827.3 8991.5 9086.2 9509.3 9668.7 8317.5 8627.5 8647.0 8684.4 8888.3 6661.6 6721.5 6886.8 6908.0 6936.4 8277.9 8789.4 8943.6 8955.5 9073.7 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | [#3] mootools.html Cycles:180 Average:4795.29 Median:5775.68 stddev:2453.35 (42.5%) stddev-sans-first:2446.84 09:16:42 INFO - PROCESS | 3712 | Values: 1383.6 1403.7 1530.3 1700.7 1735.9 5871.6 5952.1 6855.8 7027.4 7062.8 6406.2 6527.2 6562.8 6571.3 6605.3 2072.8 2097.6 2105.1 2110.9 2111.3 2066.2 2070.5 2139.3 2173.3 2175.0 2100.9 2112.7 2118.8 2131.5 2144.6 2075.6 2078.7 2105.6 2109.1 2110.8 1966.9 1980.7 1980.9 1983.8 1984.1 6984.0 6995.2 7028.2 7030.1 7035.2 4117.4 4192.6 4192.9 4201.9 4203.9 2629.3 2677.7 2702.0 2708.9 2730.9 880.1 884.3 894.2 908.5 931.4 9172.1 9305.9 9342.3 9354.1 9400.0 3809.1 3833.6 3838.1 3859.4 3909.1 8334.5 8359.2 8360.7 8371.9 8382.4 4172.2 4172.7 4194.1 4216.1 4216.1 3251.5 3339.5 3690.2 3796.9 3808.0 3363.1 3392.9 3404.5 3427.3 3436.6 1075.5 1080.7 1105.7 1114.3 1115.7 1186.5 1194.3 1203.3 1208.7 1223.3 6578.0 6588.6 6600.8 6647.3 6722.1 409.6 414.5 414.7 417.5 422.1 5033.6 5103.9 5107.2 5109.5 5120.5 7881.1 8007.2 8181.3 8435.7 8473.9 7714.2 7796.1 7892.4 7901.2 7948.8 6496.8 6653.6 6713.5 6726.8 6728.2 6492.4 6555.0 6569.8 6585.0 6595.8 6914.1 6974.5 7089.8 7463.7 7466.1 6922.6 7043.3 7098.1 7184.9 7187.5 5148.2 5322.8 5947.5 5975.6 5991.3 6369.5 6376.3 6398.0 6419.1 6422.5 5977.9 6155.4 6235.8 6236.3 6395.3 6002.8 6124.6 6124.8 6216.5 6230.8 6199.2 6316.6 6324.0 6336.8 6345.7 5671.9 5692.5 5712.7 5720.3 5736.9 5628.2 5630.1 5635.9 5677.9 5814.5 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | [#4] prototype.html Cycles:180 Average:4799.54 Median:5442.33 stddev:1417.56 (26.0%) stddev-sans-first:1380.94 09:16:42 INFO - PROCESS | 3712 | Values: 312.2 319.9 322.7 328.1 328.5 5446.4 5467.0 5539.6 5564.0 5592.7 5435.2 5508.3 5532.1 5546.3 5550.0 4140.4 4236.0 4242.0 4246.2 4250.8 4230.1 4240.4 4245.2 4253.1 4270.7 4206.9 4222.3 4227.9 4249.8 4255.6 4250.9 4257.1 4260.0 4265.1 4265.9 3551.1 3624.3 3725.6 3734.0 3734.7 5206.9 5290.4 5332.0 5343.4 5345.6 4842.5 4842.7 4844.0 4844.9 4848.5 5805.0 5812.2 5813.5 5818.1 5826.1 3876.8 3951.3 3952.2 4015.6 4032.5 5966.6 6070.5 6081.2 6081.6 6084.6 4120.6 4125.7 4127.1 4133.5 4143.8 4211.6 4213.9 4217.6 4221.6 4222.1 4711.1 4780.0 4803.9 4831.6 4833.6 5771.0 5776.4 5789.7 5790.3 5794.1 1479.1 1488.5 1489.9 1502.4 1502.8 996.4 1003.5 1008.5 1017.6 1022.5 5044.7 5054.3 5056.7 5056.9 5061.4 5960.2 5983.1 6005.4 6021.6 6023.3 5042.2 5044.8 5057.1 5063.5 5074.8 3162.8 3208.7 3231.2 3244.3 3259.7 5438.2 5565.5 5613.8 5615.8 5644.2 6063.1 6229.0 6229.2 6242.7 6262.6 5626.5 5673.5 5674.5 5676.8 5678.4 5814.4 6048.1 6056.9 6067.5 6078.9 5908.2 5909.4 5911.5 5916.9 5922.3 5632.2 5645.1 5647.8 5648.0 5667.4 4088.5 4090.4 4091.0 4100.4 4103.1 5912.1 6025.5 6050.8 6060.7 6064.2 5828.4 5837.0 5870.8 5871.5 5881.2 5778.6 5802.4 5816.5 5821.7 5824.0 5564.8 5660.2 5711.9 5713.1 5716.8 5833.9 5879.6 5887.8 5894.4 5903.1 5679.2 5681.1 5685.1 5690.4 5694.0 09:16:42 INFO - PROCESS | 3712 | 09:16:42 INFO - PROCESS | 3712 | [#5] yui.html Cycles:180 Average:11505.98 Median:43631.67 stddev:12367.94 (28.3%) stddev-sans-first:12375.95 09:16:42 INFO - PROCESS | 3712 | Values: 688.5 776.6 794.1 797.9 804.3 11622.0 11708.7 11720.6 11735.4 11770.8 11580.7 11609.4 12714.7 12973.0 12985.0 773.4 773.5 783.2 783.5 786.7 791.2 791.7 794.4 795.3 795.4 821.1 821.5 822.7 825.4 826.2 811.8 815.1 815.4 815.5 816.9 604.2 606.1 606.8 607.9 608.8 12208.4 12264.9 12270.6 12280.8 12298.1 11076.4 11348.2 11457.4 11509.9 11652.8 9185.8 9295.7 9306.6 9336.9 9364.2 3175.3 3242.2 3254.2 3271.9 3287.1 38058.6 38109.4 38458.4 38617.0 38737.2 8785.6 8826.2 9175.4 9236.3 9259.1 15570.3 15575.9 15600.5 15624.8 15655.5 6381.2 6393.4 6411.7 6526.5 6638.3 3656.0 3715.5 3733.9 3800.8 3874.0 2547.2 2566.7 2571.3 2580.7 2590.2 450.5 452.2 461.3 474.0 475.7 567.0 574.4 597.3 599.8 608.2 7484.8 8247.1 8421.7 8601.6 8631.8 525.9 563.9 578.2 615.7 633.4 3607.4 3609.7 3665.4 3856.5 3860.6 43340.8 43402.8 43459.1 43570.3 43693.0 40584.4 40899.6 40910.8 41246.8 41302.0 36512.5 36527.5 37101.8 37613.2 37819.8 7069.6 7125.3 7279.5 7418.6 7573.5 27817.7 27847.9 27957.0 28058.4 28529.3 32100.2 32184.4 32458.5 35844.6 36656.8 9142.0 9488.7 9544.8 9746.6 9952.2 10179.3 10327.8 10393.3 10402.1 11128.2 9869.5 10171.4 10246.3 10293.5 11044.2 9854.0 9869.6 10038.6 10078.7 10225.9 10797.2 10797.9 10835.1 10954.8 11108.9 8521.3 8909.3 8983.0 9059.6 9099.6 8499.4 8721.2 8837.7 8876.7 9267.9 09:16:42 INFO - PROCESS | 3712 | -------- Summary: end -------- 09:16:42 INFO - PROCESS | 3712 | 09:16:43 INFO - TEST-INFO | 3712: exit 0 09:16:43 INFO - TEST-OK | dromaeo_css | took 1112767ms 09:16:43 INFO - TEST-START | kraken 09:16:43 INFO - operating with platform_type : linux_ 09:16:43 INFO - Initialising browser for kraken test... 09:16:43 INFO - TEST-INFO | started process 3950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphknKn_/profile http://localhost:60858/getInfo.html) 09:16:47 INFO - PROCESS | 3950 | 09:16:47 INFO - PROCESS | 3950 | (process:4026): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:16:48 INFO - PROCESS | 3950 | __metrics Screen width/height:1600/1200 09:16:48 INFO - PROCESS | 3950 | colorDepth:24 09:16:48 INFO - PROCESS | 3950 | Browser inner width/height: 1024/697 09:16:48 INFO - PROCESS | 3950 | __metrics 09:16:48 INFO - PROCESS | 3950 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:16:49 INFO - TEST-INFO | 3950: exit 0 09:16:49 INFO - Browser initialized. 09:16:49 INFO - Running cycle 1/1 for kraken test... 09:16:49 INFO - TEST-INFO | started process 4075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphknKn_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:50 INFO - PROCESS | 4075 | 09:16:50 INFO - PROCESS | 4075 | (process:4135): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:17:01 INFO - PROCESS | 4075 | RSS: Main: 150761472 09:17:01 INFO - PROCESS | 4075 | 09:17:03 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-beat-detection) 09:17:04 INFO - PROCESS | 4075 | RSS: Main: 152256512 09:17:04 INFO - PROCESS | 4075 | 09:17:07 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-dft) 09:17:07 INFO - PROCESS | 4075 | RSS: Main: 154546176 09:17:07 INFO - PROCESS | 4075 | 09:17:10 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-fft) 09:17:11 INFO - PROCESS | 4075 | RSS: Main: 148541440 09:17:11 INFO - PROCESS | 4075 | 09:17:13 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60858/tests/kraken/driver.html?testName=audio-oscillator) 09:17:14 INFO - PROCESS | 4075 | RSS: Main: 149286912 09:17:14 INFO - PROCESS | 4075 | 09:17:16 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:17:16 INFO - PROCESS | 4075 | RSS: Main: 149659648 09:17:16 INFO - PROCESS | 4075 | 09:17:19 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60858/tests/kraken/driver.html?testName=imaging-darkroom) 09:17:20 INFO - PROCESS | 4075 | RSS: Main: 148721664 09:17:20 INFO - PROCESS | 4075 | 09:17:24 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60858/tests/kraken/driver.html?testName=imaging-desaturate) 09:17:24 INFO - PROCESS | 4075 | RSS: Main: 146731008 09:17:24 INFO - PROCESS | 4075 | 09:17:27 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60858/tests/kraken/driver.html?testName=json-parse-financial) 09:17:28 INFO - PROCESS | 4075 | RSS: Main: 147271680 09:17:28 INFO - PROCESS | 4075 | 09:17:29 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:17:30 INFO - PROCESS | 4075 | RSS: Main: 148717568 09:17:30 INFO - PROCESS | 4075 | 09:17:32 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:33 INFO - PROCESS | 4075 | RSS: Main: 147476480 09:17:33 INFO - PROCESS | 4075 | 09:17:35 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:35 INFO - PROCESS | 4075 | RSS: Main: 147218432 09:17:35 INFO - PROCESS | 4075 | 09:17:38 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:39 INFO - PROCESS | 4075 | RSS: Main: 147591168 09:17:39 INFO - PROCESS | 4075 | 09:17:41 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:42 INFO - PROCESS | 4075 | RSS: Main: 148656128 09:17:42 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | Cycle 1(1): loaded http://localhost:60858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60858/tests/kraken/driver.html?testName=ai-astar) 09:17:44 INFO - PROCESS | 4075 | RSS: Main: 147734528 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | __start_tp_report 09:17:44 INFO - PROCESS | 4075 | _x_x_mozilla_page_load 09:17:44 INFO - PROCESS | 4075 | _x_x_mozilla_page_load_details 09:17:44 INFO - PROCESS | 4075 | |i|pagename|runs| 09:17:44 INFO - PROCESS | 4075 | |0;ai-astar;114;109;114;114;115;126;113;114;113;115 09:17:44 INFO - PROCESS | 4075 | |1;audio-beat-detection;153;132;164;173;131;158;161;134;161;137 09:17:44 INFO - PROCESS | 4075 | |2;audio-dft;164;163;164;161;162;168;166;163;165;164 09:17:44 INFO - PROCESS | 4075 | |3;audio-fft;72;72;74;74;73;132;75;72;72;73 09:17:44 INFO - PROCESS | 4075 | |4;audio-oscillator;99;98;148;98;100;98;143;98;99;134 09:17:44 INFO - PROCESS | 4075 | |5;imaging-gaussian-blur;109;110;110;110;111;110;111;109;110;110 09:17:44 INFO - PROCESS | 4075 | |6;imaging-darkroom;148;149;147;148;148;148;148;148;147;148 09:17:44 INFO - PROCESS | 4075 | |7;imaging-desaturate;97;97;97;97;96;99;97;97;96;97 09:17:44 INFO - PROCESS | 4075 | |8;json-parse-financial;74;74;74;73;75;72;74;72;70;70 09:17:44 INFO - PROCESS | 4075 | |9;json-stringify-tinderbox;66;68;69;68;70;68;68;69;68;70 09:17:44 INFO - PROCESS | 4075 | |10;stanford-crypto-aes;92;84;85;82;90;82;93;83;83;83 09:17:44 INFO - PROCESS | 4075 | |11;stanford-crypto-ccm;120;126;122;127;126;135;134;123;122;126 09:17:44 INFO - PROCESS | 4075 | |12;stanford-crypto-pbkdf2;144;147;147;154;153;149;151;152;151;139 09:17:44 INFO - PROCESS | 4075 | |13;stanford-crypto-sha256-iterative;70;78;70;71;71;70;70;72;72;71 09:17:44 INFO - PROCESS | 4075 | __end_tp_report 09:17:44 INFO - PROCESS | 4075 | __start_cc_report 09:17:44 INFO - PROCESS | 4075 | _x_x_mozilla_cycle_collect,808 09:17:44 INFO - PROCESS | 4075 | __end_cc_report 09:17:44 INFO - PROCESS | 4075 | __startTimestamp1452791864317__endTimestamp 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | ------- Summary: start ------- 09:17:44 INFO - PROCESS | 4075 | Number of tests: 14 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:4.32 (3.8%) stddev-sans-first:4.58 09:17:44 INFO - PROCESS | 4075 | Values: 114.0 109.0 114.0 114.0 115.0 126.0 113.0 114.0 113.0 115.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:159.50 stddev:15.45 (9.7%) stddev-sans-first:16.36 09:17:44 INFO - PROCESS | 4075 | Values: 153.0 132.0 164.0 173.0 131.0 158.0 161.0 134.0 161.0 137.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.12 09:17:44 INFO - PROCESS | 4075 | Values: 164.0 163.0 164.0 161.0 162.0 168.0 166.0 163.0 165.0 164.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:18.69 (25.6%) stddev-sans-first:19.65 09:17:44 INFO - PROCESS | 4075 | Values: 72.0 72.0 74.0 74.0 73.0 132.0 75.0 72.0 72.0 73.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:98.00 stddev:21.09 (21.5%) stddev-sans-first:21.88 09:17:44 INFO - PROCESS | 4075 | Values: 99.0 98.0 148.0 98.0 100.0 98.0 143.0 98.0 99.0 134.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 09:17:44 INFO - PROCESS | 4075 | Values: 109.0 110.0 110.0 110.0 111.0 110.0 111.0 109.0 110.0 110.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:17:44 INFO - PROCESS | 4075 | Values: 148.0 149.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 09:17:44 INFO - PROCESS | 4075 | Values: 97.0 97.0 97.0 97.0 96.0 99.0 97.0 97.0 96.0 97.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#8] json-parse-financial Cycles:10 Average:72.80 Median:74.00 stddev:1.75 (2.4%) stddev-sans-first:1.80 09:17:44 INFO - PROCESS | 4075 | Values: 74.0 74.0 74.0 73.0 75.0 72.0 74.0 72.0 70.0 70.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:0.87 09:17:44 INFO - PROCESS | 4075 | Values: 66.0 68.0 69.0 68.0 70.0 68.0 68.0 69.0 68.0 70.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:4.27 (5.1%) stddev-sans-first:3.87 09:17:44 INFO - PROCESS | 4075 | Values: 92.0 84.0 85.0 82.0 90.0 82.0 93.0 83.0 83.0 83.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.00 stddev:4.98 (3.9%) stddev-sans-first:4.76 09:17:44 INFO - PROCESS | 4075 | Values: 120.0 126.0 122.0 127.0 126.0 135.0 134.0 123.0 122.0 126.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:151.00 stddev:4.60 (3.0%) stddev-sans-first:4.55 09:17:44 INFO - PROCESS | 4075 | Values: 144.0 147.0 147.0 154.0 153.0 149.0 151.0 152.0 151.0 139.0 09:17:44 INFO - PROCESS | 4075 | 09:17:44 INFO - PROCESS | 4075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.00 stddev:2.42 (3.4%) stddev-sans-first:2.50 09:17:44 INFO - PROCESS | 4075 | Values: 70.0 78.0 70.0 71.0 71.0 70.0 70.0 72.0 72.0 71.0 09:17:44 INFO - PROCESS | 4075 | -------- Summary: end -------- 09:17:44 INFO - PROCESS | 4075 | 09:17:45 INFO - TEST-INFO | 4075: exit 0 09:17:45 INFO - TEST-OK | kraken | took 61821ms 09:17:45 INFO - TEST-START | v8_7 09:17:45 INFO - operating with platform_type : linux_ 09:17:45 INFO - Initialising browser for v8_7 test... 09:17:45 INFO - TEST-INFO | started process 4367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp17Qke1/profile http://localhost:60858/getInfo.html) 09:17:49 INFO - PROCESS | 4367 | 09:17:49 INFO - PROCESS | 4367 | (process:4439): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:17:49 INFO - PROCESS | 4367 | __metrics Screen width/height:1600/1200 09:17:49 INFO - PROCESS | 4367 | colorDepth:24 09:17:49 INFO - PROCESS | 4367 | Browser inner width/height: 1024/697 09:17:49 INFO - PROCESS | 4367 | __metrics 09:17:50 INFO - PROCESS | 4367 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:17:51 INFO - TEST-INFO | 4367: exit 0 09:17:51 INFO - Browser initialized. 09:17:51 INFO - Running cycle 1/1 for v8_7 test... 09:17:51 INFO - TEST-INFO | started process 4489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp17Qke1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:52 INFO - PROCESS | 4489 | 09:17:52 INFO - PROCESS | 4489 | (process:4546): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:03 INFO - PROCESS | 4489 | RSS: Main: 150396928 09:18:03 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | Cycle 1(1): loaded http://localhost:60858/tests/v8_7/run.html (next: http://localhost:60858/tests/v8_7/run.html) 09:18:25 INFO - PROCESS | 4489 | RSS: Main: 146280448 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | __start_tp_report 09:18:25 INFO - PROCESS | 4489 | _x_x_mozilla_page_load 09:18:25 INFO - PROCESS | 4489 | _x_x_mozilla_page_load_details 09:18:25 INFO - PROCESS | 4489 | |i|pagename|runs| 09:18:25 INFO - PROCESS | 4489 | |0;Richards;166.25103906899417 09:18:25 INFO - PROCESS | 4489 | |1;DeltaBlue;186.9158878504673 09:18:25 INFO - PROCESS | 4489 | |2;Encrypt;277.39251040221916 09:18:25 INFO - PROCESS | 4489 | |3;Decrypt;5273.684210526316 09:18:25 INFO - PROCESS | 4489 | |4;RayTrace;1062.6992561105208 09:18:25 INFO - PROCESS | 4489 | |5;Earley;711.9487908961593 09:18:25 INFO - PROCESS | 4489 | |6;Boyer;12382.716049382716 09:18:25 INFO - PROCESS | 4489 | |7;RegExp;42723.40425531915 09:18:25 INFO - PROCESS | 4489 | |8;Splay;600.2400960384153 09:18:25 INFO - PROCESS | 4489 | |9;NavierStokes;4830.917874396136 09:18:25 INFO - PROCESS | 4489 | __end_tp_report 09:18:25 INFO - PROCESS | 4489 | __startTimestamp1452791905826__endTimestamp 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | ------- Summary: start ------- 09:18:25 INFO - PROCESS | 4489 | Number of tests: 10 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 166.3 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#1] DeltaBlue Cycles:1 Average:186.92 Median:186.92 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 186.9 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#2] Encrypt Cycles:1 Average:277.39 Median:277.39 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 277.4 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 5273.7 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 1062.7 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#5] Earley Cycles:1 Average:711.95 Median:711.95 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 711.9 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 12382.7 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#7] RegExp Cycles:1 Average:42723.40 Median:42723.40 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 42723.4 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#8] Splay Cycles:1 Average:600.24 Median:600.24 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 600.2 09:18:25 INFO - PROCESS | 4489 | 09:18:25 INFO - PROCESS | 4489 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:18:25 INFO - PROCESS | 4489 | Values: 4830.9 09:18:25 INFO - PROCESS | 4489 | -------- Summary: end -------- 09:18:25 INFO - PROCESS | 4489 | 09:18:26 INFO - TEST-INFO | 4489: exit 0 09:18:26 INFO - TEST-OK | v8_7 | took 41471ms 09:18:26 INFO - SUITE-END | took 1216s 09:18:26 INFO - Completed test suite (00:20:16) 09:18:26 INFO - Working with test: dromaeo_css 09:18:26 INFO - Generating results file: dromaeo_css 09:18:26 INFO - Working with test: kraken 09:18:26 INFO - Generating results file: kraken 09:18:26 INFO - javascript benchmark 09:18:26 INFO - Working with test: v8_7 09:18:26 INFO - Generating results file: v8_7 09:18:26 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:18:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 09:18:26 INFO - process_Request line: dromaeo_css 6107.05 graph.html#tests=[[72,132,43]] 09:18:26 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:18:26 INFO - process_Request line: kraken 1547.60 graph.html#tests=[[232,132,43]] 09:18:26 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:18:26 INFO - process_Request line: v8_7 20321.21 graph.html#tests=[[230,132,43]] 09:18:26 INFO - RETURN: dromaeo_css: 6107.05 09:18:26 INFO - RETURN: kraken: 1547.60 09:18:26 INFO - RETURN: v8_7: 20321.21 09:18:26 INFO - javascript benchmark 09:18:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2613.699424566175, 2634.275574217091, 2661.5342315094867, 2668.4396276781886, 2678.183154137988, 4424.668149888755, 4430.8449204277895, 4451.332300154978, 4451.710638808475, 4479.216137175989, 4477.417935668359, 4488.775561221934, 4492.124035813018, 4537.546245375469, 4555.5899969002785, 41.448648278484434, 4191.7694526801015, 4216.0513884376, 4233.724807887493, 4289.227938970984, 3977.602239776028, 4180.5610410906875, 4195.349720793267, 4196.748195108304, 4257.510386305568, 4199.958000420018, 4200.663946884257, 4203.97898010511, 4234.788260586974, 4243.97878010611, 4044.373122166069, 4135.028268356934, 4248.702590818644, 4254.127903779718, 4319.287317592593, 4116.9794151029355, 4203.201391735561, 4243.278642630729, 4253.723882835168, 4298.075913678574, 4415.2935530315, 4443.0, 4457.086297309076, 4477.126960242754, 4478.283474644074, 4685.6485763567525, 4773.546513081286, 4848.151573474628, 4854.150523658381, 4855.344528488644, 4823.397075365579, 4829.3721816164025, 4841.983183531463, 4844.055409195208, 4885.145099607555, 4464.508904020555, 4466.39703640011, 4474.127545128668, 4491.30384790358, 4527.547245275512, 4815.892344760725, 4893.853184404474, 4898.926516102261, 4905.484924082992, 4906.656534042583, 4745.905081898342, 4764.14245435818, 4771.0, 4771.33201351811, 4812.181929072066, 4848.5636292733825, 4855.587275081587, 4859.2954021667365, 4864.100141473838, 4899.559039686445, 4666.580007799314, 4716.0, 4771.785269662873, 4781.258904869751, 4797.064572408347, 4670.976645116821, 4676.672632915731, 4703.0, 4726.621870250372, 4755.215389460769, 3931.2334094851803, 3937.409388591734, 3964.72246942717, 3988.541317748438, 3995.6403923647013, 3459.4810778383444, 3475.669811367916, 3502.2470168913806, 3528.7177025837873, 3529.752917295816, 4066.0, 4069.2878746219294, 4075.653569446571, 4116.135611521554, 4141.482314710661, 4665.86002419928, 4673.088747694167, 4683.836065737751, 4696.60078893291, 4704.529547045268, 4133.937990930139, 4167.166566686675, 4200.1179752251755, 4219.451471308772, 4240.554741752133, 4218.535961044283, 4255.085156691326, 4263.062126332202, 4279.122779830127, 4279.614834664832, 4478.596926276651, 4532.1842068427995, 4550.067236216568, 4569.543045695404, 4611.608013318905, 4733.5266473352385, 4734.431868175841, 4776.761161941959, 4778.689385189951, 4825.324454576292, 4531.660125490535, 4551.112533056023, 4573.176828170828, 4573.428321459817, 4617.8383756568355, 4578.839740609063, 4653.697509661861, 4757.595604373529, 4761.500042495627, 4824.710517368969, 4662.533746625446, 4701.623870090453, 4712.363830882924, 4732.2428411454, 4761.357216775829, 4598.402207712976, 4640.791164397678, 4644.071185762793, 4646.163690535736, 4679.859604211879, 4494.4606647202545, 4566.1552612766745, 4590.6557008223845, 4626.86119416418, 4637.304404339376, 4584.679072464895, 4596.080783843312, 4625.213713668752, 4625.7918393673035, 4639.698419602715, 4661.114388266218, 4683.765811709332, 4690.742009189527, 4697.8355757548325, 4700.012997270612, 4448.35498852671, 4455.888602784827, 4525.343825145402, 4527.298268768346, 4552.817887284604], "unit": "score", "name": "dojo.html", "value": 4376.3658475767725}, {"lowerIsBetter": false, "replicates": [493.56812788809793, 521.2780299285488, 536.5787856532622, 542.7679168287987, 552.3509875895822, 31405.0, 32241.35517289653, 32301.51547726786, 32308.192295192603, 32344.67655323446, 35421.11447213821, 35863.10342241445, 35903.4614480783, 35908.82045589769, 36038.09904752383, 7623.69505219792, 7794.64924078415, 7817.140114587391, 7818.804529886742, 7860.331871790904, 7578.393728501735, 7661.118971318314, 7664.961675191644, 7898.723544675938, 7908.367330613566, 7884.172161923001, 7931.325837303836, 7962.084360298553, 7972.3622110231045, 7977.521348719067, 7789.104253010892, 7855.0, 7885.211478852098, 7901.525908445454, 7917.722879699211, 7832.882506762403, 7952.284294413531, 7968.60156992148, 7971.72098976533, 7996.760097197093, 36386.27227455463, 36810.63189368099, 36870.8156459216, 36911.26177476462, 36912.07719807026, 2400.3159099656514, 2915.1691767846273, 2944.2492164497917, 3063.3107550801114, 3081.8613162407523, 23603.881980589988, 28125.85937070322, 28845.0, 29883.551746723817, 31405.84297078523, 3390.6609339066144, 3435.879744208941, 3453.0, 3487.6861082502696, 3550.4496802995577, 176613.0, 176834.11582942132, 177227.0, 177459.0, 177997.0, 46193.53806461892, 47134.29298560524, 50355.24467132996, 50726.49273507218, 55523.0, 48431.757841210565, 48719.0, 48891.75554122207, 48914.75542622335, 49000.509994900305, 13420.261885596386, 13553.322333883267, 13685.11046781956, 13692.726145477034, 13706.65733356674, 10679.946600266949, 10738.892611073945, 10745.194110441747, 10772.569097236023, 10781.460926953621, 18498.445046648623, 18794.530136746416, 18840.717389239173, 18859.3399231029, 18888.81111188898, 7078.362947334765, 7258.600776957318, 7264.745733899288, 7298.598577078312, 7310.96344518274, 898.8247291778172, 903.5798353765531, 915.6520522201654, 975.5756246032998, 1082.4912291223113, 26426.867865660934, 26712.332191695365, 26992.0, 27047.594286085725, 27265.45469090607, 989.9059589339001, 993.8012397520525, 1003.5935446144323, 1013.1540163963173, 1051.5163025008583, 14245.64385890361, 15354.692906141814, 15723.21383930799, 15875.52373428799, 16206.756898646294, 298655.0, 302488.0, 302809.0, 303205.0, 303991.0, 47035.76482117636, 47385.28922066172, 47649.0, 47887.76056119697, 47907.520924790304, 1244.4524409260077, 1249.1006475337742, 1252.2298786246574, 1256.0893352319679, 1276.16411250631, 25704.228873133838, 26762.866185668947, 26808.8659556701, 27336.589951151145, 27827.44345113127, 38614.613853861105, 39526.0, 39609.0, 39626.60373396229, 39655.80172099121, 233903.0, 236814.0, 237515.0, 238053.0, 238503.0, 38148.0, 38556.42165367578, 38561.42157867578, 38967.415488767125, 39004.0, 36488.27023459569, 37747.245055098196, 38021.619783801805, 38265.04337391476, 38364.0, 31898.36203275968, 32238.677613224507, 32281.51577726289, 32921.506177407835, 33181.83409082939, 32640.34719305553, 32697.836510817295, 35062.29875402529, 36623.08442288964, 36978.0, 32605.836970814995, 33116.1720956978, 33186.0, 33253.66746332506, 33350.499742503394, 30889.536656949713, 32116.67883321137, 32397.51403728993, 32795.508067378534, 32928.1767955803, 26104.0, 26198.90408767256, 26512.867435662698, 26516.734832651426, 26572.33569160709], "unit": "score", "name": "ext.html", "value": 16833.522457655654}, {"lowerIsBetter": false, "replicates": [335.59895924370386, 342.68175790775405, 343.7799808122802, 345.666431893223, 352.22686203782706, 13844.792328115074, 14001.719965600681, 14768.187749673763, 15424.920255582085, 15589.0, 13812.654683632914, 13928.791068133985, 14781.187034713086, 14840.109593424375, 14856.702865942674, 4505.864824055284, 4555.977220113903, 4653.27874179501, 4658.045100754337, 4927.778249978742, 5025.321581586476, 5046.293518907356, 5049.823256186034, 5069.340985671876, 5069.797208111671, 4950.306957026001, 5294.364676238857, 5296.073187192245, 5298.576113910897, 5318.946810531884, 5179.067767801795, 5218.13900706383, 5283.365996080475, 5295.417504074549, 5801.53587712982, 5117.66735162217, 5125.3080834087295, 5126.743662816844, 5139.820106296299, 5164.044651739403, 11229.775404491946, 15900.76148857768, 17483.0, 18163.184706370535, 18200.1809918554, 1838.3014454507336, 1862.1713337564788, 1865.4496923407628, 1883.660941030614, 1889.4520589029164, 9069.455832650063, 9229.676961306322, 10627.309224900357, 10788.676339709822, 12148.5140594377, 1716.0, 1781.1094452773614, 1784.9375271865551, 1803.2877013579694, 1815.5188874948017, 47438.525614743754, 48986.51013489855, 49273.0, 49283.50716492825, 49309.50690493085, 9379.0, 9558.426494410358, 9623.56693948774, 9677.37097088687, 9684.08001239881, 12314.13801033919, 12349.629511114681, 12356.567520136932, 12405.379731013594, 12431.875681243253, 6766.76316328936, 6826.419754320839, 6869.896951545731, 6898.206706228848, 7028.367446929801, 6597.538172327891, 6614.570052946543, 6621.569597976116, 6646.102776125258, 6649.667516624149, 3722.683571896419, 3906.1015966327336, 3961.3859851723028, 4115.094679170577, 4134.069834287321, 1669.1654172913543, 1798.6582549315588, 1802.648483545696, 1814.2833580735798, 1824.206470185447, 815.514768712615, 848.5799529233069, 854.3293514591016, 875.5709702245854, 1013.8732658417698, 13838.15916775556, 13868.514601988882, 14170.574882753534, 14267.0, 14595.85404145945, 826.5867066466767, 827.4580150001758, 855.0167307596314, 864.6973559254336, 961.2022021721954, 6776.42400395962, 8099.190080991853, 8245.422820402635, 8283.710070147516, 8344.457610255315, 403302.0, 406168.0, 414555.0, 432220.0, 433684.0, 36488.635113648525, 36662.26675466476, 53442.465575344526, 60006.099908501405, 61766.0735088974, 1092.3118435385657, 1094.8521949536869, 1101.388729255271, 1107.0, 1109.5949978258038, 12579.119461637598, 12751.93624031911, 12771.169873958162, 12877.549285774952, 12973.675658108623, 26250.474990500465, 26921.192364229104, 27068.45863082688, 27540.173794786187, 28326.15021549357, 39396.60603394044, 39652.603473966046, 39720.404193936534, 39743.80128099341, 40098.59901401065, 6775.695093720696, 6780.25417204117, 6895.931040689529, 6907.758228461979, 6991.720331186695, 9285.164335209864, 9397.953010234905, 9871.802563948824, 9934.105930466292, 9980.451075190644, 8498.787530311793, 8710.346723995599, 8980.191782739323, 8982.146696063863, 9019.729408117766, 8827.337949653931, 8991.460512369278, 9086.22767064807, 9509.334346595671, 9668.70993870185, 8317.500949943023, 8627.525486098324, 8647.048824629412, 8684.39209255346, 8888.288936884905, 6661.600303981777, 6721.462283017249, 6886.793396198122, 6908.032875397549, 6936.445084393337, 8277.875831862648, 8789.42868713557, 8943.597538110931, 8955.507447090473, 9073.727788166365], "unit": "score", "name": "jquery.html", "value": 7402.957453612845}, {"lowerIsBetter": false, "replicates": [1383.626420866366, 1403.6911879386532, 1530.31135988805, 1700.6938751024811, 1735.869809764268, 5871.588988770788, 5952.136940143677, 6855.79432617021, 7027.367536921676, 7062.823429414268, 6406.167198264231, 6527.184101987252, 6562.8031159065185, 6571.277159512461, 6605.339466053392, 2072.8134467897885, 2097.622427962966, 2105.0842883345717, 2110.89445527723, 2111.282164064218, 2066.2354928676336, 2070.4720296324417, 2139.3474990128007, 2173.315405647224, 2175.042981088324, 2100.905459254337, 2112.7464704235513, 2118.8199003084756, 2131.4990977120365, 2144.5925274197853, 2075.6056349293585, 2078.7193728846564, 2105.631514484967, 2109.1141720477435, 2110.757262914761, 1966.9213231470724, 1980.6731889238258, 1980.8811471311767, 1983.7917018712972, 1984.0972357577268, 6983.9873218383555, 6995.230524642286, 7028.226895041541, 7030.050943122716, 7035.1557813062245, 4117.382392641098, 4192.643625291854, 4192.895177620553, 4201.936970945439, 4203.91592168155, 2629.250663560876, 2677.6920654124638, 2702.0, 2708.91873243803, 2730.945381092387, 880.1022956584249, 884.3146561414891, 894.217559635319, 908.5184852028435, 931.4364809290417, 9172.08279172084, 9305.860412093823, 9342.299327550392, 9354.06459354066, 9400.0, 3809.142942837839, 3833.616638336144, 3838.1172330363615, 3859.3824988001784, 3909.100906791397, 8334.49993000422, 8359.205875441823, 8360.749177524684, 8371.874421883676, 8382.371322150862, 4172.165566886635, 4172.749635021908, 4194.0563373240775, 4216.051388437577, 4216.072464057902, 3251.4635085210675, 3339.532465454838, 3690.1881586051027, 3796.924061518754, 3807.961920380816, 3363.142398688368, 3392.9491057634154, 3404.455287154093, 3427.3488037272837, 3436.5876094868277, 1075.5482697267166, 1080.7028067281403, 1105.7401510644993, 1114.3146964616865, 1115.726646971481, 1186.4601606269127, 1194.3132698698282, 1203.3201241298639, 1208.6796998795326, 1223.2966044524435, 6577.967110164419, 6588.604683718992, 6600.80197594073, 6647.268800432045, 6722.092517510074, 409.6313318013752, 414.52122798168165, 414.65583565640446, 417.5177669791396, 422.1430496092936, 5033.597312215087, 5103.8724031898755, 5107.208382700687, 5109.514596113363, 5120.513551212629, 7881.054273487218, 8007.239312265326, 8181.304589109992, 8435.70475033383, 8473.915260847436, 7714.228577142241, 7796.064472263365, 7892.368610511146, 7901.249381308767, 7948.841023179504, 6496.805095847132, 6653.567518111404, 6713.462922966249, 6726.7981960541265, 6728.158980127484, 6492.415682588401, 6555.049517819794, 6569.835754106186, 6585.0, 6595.835104122243, 6914.135733033371, 6974.4769142315545, 7089.7873063808165, 7463.738769143054, 7466.104067511933, 6922.584644921119, 7043.295670432915, 7098.148222213367, 7184.856302873809, 7187.460940429384, 5148.176291793295, 5322.813701520428, 5947.494462970523, 5975.641461512323, 5991.310999234969, 6369.49044076482, 6376.330485298977, 6398.0083087121575, 6419.101325814483, 6422.486201103994, 5977.880442391041, 6155.415235552616, 6235.781747638811, 6236.251649802053, 6395.296517383177, 6002.849928751816, 6124.6325220486915, 6124.816255512342, 6216.502679785697, 6230.844228894314, 6199.194104766351, 6316.589421687576, 6323.968380158254, 6336.809895703136, 6345.682715864096, 5671.858203544779, 5692.459216374438, 5712.742926568398, 5720.342160651412, 5736.885262294814, 5628.240187574625, 5630.071038278638, 5635.9436405635415, 5677.943220567741, 5814.476697097281], "unit": "score", "name": "mootools.html", "value": 3912.7566804695325}, {"lowerIsBetter": false, "replicates": [312.18363978197016, 319.86885376995434, 322.7305200157868, 328.1369996908131, 328.4908391992411, 5446.4281250468675, 5466.972665136669, 5539.584531160164, 5563.972180139103, 5592.664440133595, 5435.157550579666, 5508.3114610673665, 5532.087205611069, 5546.334439867212, 5549.972250138743, 4140.378943158536, 4236.0, 4241.957580424202, 4246.193223287565, 4250.787460626956, 4230.090530535934, 4240.448741663595, 4245.193413251488, 4253.085586598881, 4270.701050926421, 4206.8737937861915, 4222.282212023963, 4227.894302642443, 4249.787510624472, 4255.63827074699, 4250.851220207278, 4257.127288905783, 4260.0, 4265.104328091104, 4265.936010959838, 3551.1122219445137, 3624.3476174288617, 3725.608811074825, 3734.047817806442, 3734.663880250763, 5206.895862082775, 5290.444503327134, 5332.0, 5343.385510666284, 5345.572354211654, 4842.539958703917, 4842.709437433765, 4844.0, 4844.927326090112, 4848.466668666444, 5805.042168042268, 5812.157237200625, 5813.505852002585, 5818.1272809078555, 5826.067829147316, 3876.8061596920325, 3951.269015232191, 3952.229315283521, 4015.5984401559904, 4032.5362583303004, 5966.642001479881, 6070.544709146788, 6081.17904082952, 6081.5742897996715, 6084.634921904656, 4120.62914337711, 4125.711200215956, 4127.112670775798, 4133.545310015956, 4143.834246630101, 4211.620954114144, 4213.852515161954, 4217.62041416274, 4221.6200541951375, 4222.071144348239, 4711.128441238382, 4779.976100119547, 4803.879903002453, 4831.565159135695, 4833.637477189225, 5771.0, 5776.364599894008, 5789.710514474259, 5790.334111577138, 5794.072948328248, 1479.112532480503, 1488.4567132996378, 1489.8510148985015, 1502.361496364041, 1502.8422015688195, 996.3772642098688, 1003.5433877585826, 1008.495752123938, 1017.5675337981477, 1022.5347466902541, 5044.722540260247, 5054.292399064134, 5056.721880296545, 5056.9494305057215, 5061.417936937226, 5960.195373624592, 5983.102534619842, 6005.369436209223, 6021.608595441282, 6023.307319658208, 5042.168042273057, 5044.772985215674, 5057.089723849669, 5063.544281014726, 5074.771635276422, 3162.8418579070953, 3208.727258183034, 3231.2406584452633, 3244.3186930744337, 3259.7392208623255, 5438.238646589481, 5565.526930210896, 5613.775448981995, 5615.831525054255, 5644.153376993484, 6063.120847477091, 6229.0, 6229.221347331583, 6242.65665388408, 6262.5929314594405, 5626.465485778845, 5673.517750991047, 5674.546036317085, 5676.801311954062, 5678.375378708339, 5814.418558144152, 6048.0625503047095, 6056.939430605637, 6067.514598832171, 6078.939210607838, 5908.231929849092, 5909.3795151508475, 5911.527077833849, 5916.940830591639, 5922.2597175353085, 5632.211490391431, 5645.125005624135, 5647.774089036557, 5648.039833228278, 5667.40492248308, 4088.529819070726, 4090.4068910008477, 4090.9795451022555, 4100.425940368411, 4103.117829666636, 5912.083627037816, 6025.457708806229, 6050.757969681339, 6060.6666633333825, 6064.211652485149, 5828.358880523054, 5837.036888913452, 5870.823875283749, 5871.530277577698, 5881.206037184926, 5778.56660750437, 5802.4197580241635, 5816.534677225727, 5821.679807610452, 5824.0, 5564.7575334263975, 5660.179274005329, 5711.8857622848145, 5713.085906254979, 5716.828495145152, 5833.883322333614, 5879.617824841372, 5887.793927212527, 5894.440028197314, 5903.085021821625, 5679.17651940458, 5681.062624667049, 5685.147227915846, 5690.402507736628, 5693.975084484832], "unit": "score", "name": "prototype.html", "value": 4347.208463830007}, {"lowerIsBetter": false, "replicates": [688.4733179117974, 776.646625785267, 794.122494643419, 797.9082405523363, 804.2962407893093, 11622.0, 11708.707282317946, 11720.648380548586, 11735.354555499443, 11770.764584708311, 11580.65258042258, 11609.361485118316, 12714.68213294668, 12973.027022973267, 12985.0, 773.404478551515, 773.5010917957914, 783.248081841433, 783.4633276205789, 786.6931896560318, 791.2325044706625, 791.7426836278232, 794.3962588432775, 795.2564352330561, 795.4352409789028, 821.0885916632533, 821.4906757810136, 822.7243873302451, 825.405707890318, 826.1738261738262, 811.7848770075934, 815.1033862750986, 815.3599424451777, 815.5106935838479, 816.9387295952768, 604.2115039872964, 606.1453350775386, 606.7542645228646, 607.8571535689109, 608.7595399817092, 12208.389580520938, 12264.877351226552, 12270.570530031495, 12280.815787763191, 12298.139130260884, 11076.39079850608, 11348.205625606211, 11457.36984465854, 11509.884901151048, 11652.825207621892, 9185.816283674356, 9295.72112836616, 9306.581203845843, 9336.90663093374, 9364.204042656382, 3175.3173067790535, 3242.1732458223237, 3254.2027203335333, 3271.9345613087844, 3287.096048586634, 38058.61941380578, 38109.428358574645, 38458.42312365317, 38617.0, 38737.22525549502, 8785.560721963877, 8826.205641492297, 9175.357724959189, 9236.261099112055, 9259.120383563552, 15570.299336529883, 15575.922120389325, 15600.531984040497, 15624.843751562566, 15655.512726291212, 6381.202349706286, 6393.392627700361, 6411.711472983727, 6526.477881769447, 6638.336166383419, 3655.990072611459, 3715.498407714978, 3733.8693145739767, 3800.7719536827326, 3874.0, 2547.197632745679, 2566.6535017772735, 2571.3314538219824, 2580.729023452548, 2590.2099859542645, 450.49994506098204, 452.16575418353085, 461.3448902558375, 473.9502352253033, 475.7217028038567, 567.0, 574.3567204730729, 597.3280059932575, 599.7960693364278, 608.191105829246, 7484.775456736306, 8247.092819789817, 8421.747347579583, 8601.61292741828, 8631.827363452821, 525.8974499972545, 563.9492445679908, 578.1587789765881, 615.741388616782, 633.4227772845674, 3607.440846668718, 3609.729270304738, 3665.3585622515952, 3856.4986551748652, 3860.613938606173, 43340.78329608395, 43402.782986084865, 43459.13081738348, 43570.346444803356, 43693.0, 40584.39123413092, 40899.591004089576, 40910.79544602258, 41246.793766030976, 41302.0, 36512.45231321586, 36527.4520882187, 37101.814490927914, 37613.247735045145, 37819.81090094587, 7069.646517673993, 7125.251848556034, 7279.4540409468445, 7418.591977441292, 7573.507721998052, 27817.721822781514, 27847.86076069607, 27957.0, 28058.43883122285, 28529.28676783097, 32100.197495061875, 32184.35631287408, 32458.513122303655, 35844.64155358413, 36656.81671591625, 9141.954290228507, 9488.715338539854, 9544.809103817746, 9746.610135594497, 9952.203823694232, 10179.338343007681, 10327.793444130924, 10393.324433911772, 10402.063814256451, 11128.1653875958, 9869.506524673881, 10171.38971661673, 10246.333988290737, 10293.53679084428, 11044.171687123659, 9853.950730246303, 9869.555869985725, 10038.598456061676, 10078.697639070839, 10225.948870255601, 10797.190210734068, 10797.892021080002, 10835.133189344991, 10954.835677464685, 11108.944455277671, 8521.275691566287, 8909.33807382603, 8982.955085224532, 9059.637614495346, 9099.590518426554, 8499.362547808816, 8721.171488708562, 8837.734867953972, 8876.733697989072, 9267.860982085409], "unit": "score", "name": "yui.html", "value": 5591.8180831255095}], "name": "dromaeo_css", "value": 6107.042809164236}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 114.0, 115.0, 126.0, 113.0, 114.0, 113.0, 115.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 164.0, 173.0, 131.0, 158.0, 161.0, 134.0, 161.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 164.0, 161.0, 162.0, 168.0, 166.0, 163.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 74.0, 74.0, 73.0, 132.0, 75.0, 72.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [99.0, 98.0, 148.0, 98.0, 100.0, 98.0, 143.0, 98.0, 99.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 99.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 73.0, 75.0, 72.0, 74.0, 72.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 69.0, 68.0, 70.0, 68.0, 68.0, 69.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [92.0, 84.0, 85.0, 82.0, 90.0, 82.0, 93.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [120.0, 126.0, 122.0, 127.0, 126.0, 135.0, 134.0, 123.0, 122.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [144.0, 147.0, 147.0, 154.0, 153.0, 149.0, 151.0, 152.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [70.0, 78.0, 70.0, 71.0, 71.0, 70.0, 70.0, 72.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1547.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [186.9158878504673], "unit": "score", "name": "DeltaBlue", "value": 353.73129999999986}, {"lowerIsBetter": false, "replicates": [277.39251040221916], "unit": "score", "name": "Encrypt", "value": 959.5825049999997}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [711.9487908961593], "unit": "score", "name": "Earley", "value": 936.1108671328676}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [42723.40425531915], "unit": "score", "name": "RegExp", "value": 21.32285607569722}, {"lowerIsBetter": false, "replicates": [600.2400960384153], "unit": "score", "name": "Splay", "value": 135.764006}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20321.208419604183}]} 09:18:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20321.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1547.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6107.05"}}} 09:18:27 INFO - Return code: 0 09:18:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:18:27 INFO - # TBPL SUCCESS # 09:18:27 INFO - Running post-action listener: _resource_record_post_action 09:18:27 INFO - Running post-run listener: _resource_record_post_run 09:18:28 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 324214784; Read time: 0; Write time: 227232 09:18:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20271104; Read time: 0; Write time: 5384 09:18:28 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 303943680; Read time: 0; Write time: 221848 09:18:28 INFO - Running post-run listener: _upload_blobber_files 09:18:28 INFO - Blob upload gear active. 09:18:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:18:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:18:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:18:29 INFO - (blobuploader) - INFO - Done attempting. 09:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:18:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:18:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:18:30 INFO - (blobuploader) - INFO - Done attempting. 09:18:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:18:30 INFO - Return code: 0 09:18:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:18:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:18:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1323bc27195b823f2a9df0e162ed77a56d84a53ba0118d382c6ea31621db83df3d314971328cf34a5aa031f52cc8565e0ce88769afc4594cf185437a3eb35acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daf6059414b0f0d29aeca7dd1a7909bc9bb33abb38f0f9eb0a0548f26ea0e5d1f0b4ab5ad8650b48530575158b38286cb893de21c7a498de4932a27c558792e5"} 09:18:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:18:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:18:30 INFO - Contents: 09:18:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1323bc27195b823f2a9df0e162ed77a56d84a53ba0118d382c6ea31621db83df3d314971328cf34a5aa031f52cc8565e0ce88769afc4594cf185437a3eb35acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daf6059414b0f0d29aeca7dd1a7909bc9bb33abb38f0f9eb0a0548f26ea0e5d1f0b4ab5ad8650b48530575158b38286cb893de21c7a498de4932a27c558792e5"} 09:18:30 INFO - Copying logs to upload dir... 09:18:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1298.273432 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-01-14 09:18:29.506247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 09:18:29.510073) ========= 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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1323bc27195b823f2a9df0e162ed77a56d84a53ba0118d382c6ea31621db83df3d314971328cf34a5aa031f52cc8565e0ce88769afc4594cf185437a3eb35acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daf6059414b0f0d29aeca7dd1a7909bc9bb33abb38f0f9eb0a0548f26ea0e5d1f0b4ab5ad8650b48530575158b38286cb893de21c7a498de4932a27c558792e5"} build_url:https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/AQFdGYp7RiaK1YR-s7Qaew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1323bc27195b823f2a9df0e162ed77a56d84a53ba0118d382c6ea31621db83df3d314971328cf34a5aa031f52cc8565e0ce88769afc4594cf185437a3eb35acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/daf6059414b0f0d29aeca7dd1a7909bc9bb33abb38f0f9eb0a0548f26ea0e5d1f0b4ab5ad8650b48530575158b38286cb893de21c7a498de4932a27c558792e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 09:18:29.536943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:18:29.537426) ========= 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=523ca41ca1e0623de333ad52000001bf-1452788609.983312-770541021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 09:18:29.620254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 09:18:29.620633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 09:18:29.621001) ========= ========= Total master_lag: 0.27 =========