builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1451431824.48 results: success (0) buildid: 20151229144335 builduid: 9a139e8575a14d5496caaa0449265b40 revision: 0c12d4229be0068eb1b9beb5064b800f12143f20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.485297) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.485711) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.486001) ========= 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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006267 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.514225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.514511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.562471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.563022) ========= 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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.625232) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.625491) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.625822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.626183) ========= 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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 15:30:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.3M=0s 2015-12-29 15:30:24 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171570 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.820461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.820730) ========= 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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018342 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.875074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.875394) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c12d4229be0068eb1b9beb5064b800f12143f20 --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 0c12d4229be0068eb1b9beb5064b800f12143f20 --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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 15:30:25,063 truncating revision to first 12 chars 2015-12-29 15:30:25,063 Setting DEBUG logging. 2015-12-29 15:30:25,063 attempt 1/10 2015-12-29 15:30:25,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c12d4229be0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 15:30:25,302 unpacking tar archive at: fx-team-0c12d4229be0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523986 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.412133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.412445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.422749) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.423111) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.423642) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-29 15:30:25.423921) ========= /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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:25 INFO - MultiFileLogger online at 20151229 15:30:25 in /builds/slave/test 15:30:25 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 15:30:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:25 INFO - {'append_to_log': False, 15:30:25 INFO - 'base_work_dir': '/builds/slave/test', 15:30:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:30:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:25 INFO - 'branch': 'Fx-Team-Non-PGO', 15:30:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:25 INFO - 'config_files': ('talos/linux_config.py',), 15:30:25 INFO - 'default_actions': ('clobber', 15:30:25 INFO - 'read-buildbot-config', 15:30:25 INFO - 'download-and-extract', 15:30:25 INFO - 'populate-webroot', 15:30:25 INFO - 'create-virtualenv', 15:30:25 INFO - 'install', 15:30:25 INFO - 'run-tests'), 15:30:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:25 INFO - 'download_minidump_stackwalk': True, 15:30:25 INFO - 'download_symbols': 'ondemand', 15:30:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:25 INFO - 'installer_path': 'installer.exe', 15:30:25 INFO - 'log_level': 'info', 15:30:25 INFO - 'log_name': 'talos', 15:30:25 INFO - 'log_to_console': True, 15:30:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:25 INFO - 'opt_config_files': (), 15:30:25 INFO - 'pip_index': False, 15:30:25 INFO - 'sps_profile': False, 15:30:25 INFO - 'sps_profile_interval': 0, 15:30:25 INFO - 'suite': 'dromaeojs-e10s', 15:30:25 INFO - 'system_bits': '32', 15:30:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:25 INFO - 'title': 'talos-linux64-ix-033', 15:30:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:25 INFO - 'use_talos_json': True, 15:30:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:25 INFO - 'work_dir': 'build'} 15:30:25 INFO - ##### 15:30:25 INFO - ##### Running clobber step. 15:30:25 INFO - ##### 15:30:25 INFO - Running pre-action listener: _resource_record_pre_action 15:30:25 INFO - Running main action method: clobber 15:30:25 INFO - rmtree: /builds/slave/test/build 15:30:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:26 INFO - Running post-action listener: _resource_record_post_action 15:30:26 INFO - ##### 15:30:26 INFO - ##### Running read-buildbot-config step. 15:30:26 INFO - ##### 15:30:26 INFO - Running pre-action listener: _resource_record_pre_action 15:30:26 INFO - Running main action method: read_buildbot_config 15:30:26 INFO - Using buildbot properties: 15:30:26 INFO - { 15:30:26 INFO - "project": "", 15:30:26 INFO - "product": "firefox", 15:30:26 INFO - "script_repo_revision": "production", 15:30:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:30:26 INFO - "repository": "", 15:30:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:30:26 INFO - "buildid": "20151229144335", 15:30:26 INFO - "pgo_build": "False", 15:30:26 INFO - "basedir": "/builds/slave/test", 15:30:26 INFO - "buildnumber": 862, 15:30:26 INFO - "slavename": "talos-linux64-ix-033", 15:30:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:30:26 INFO - "platform": "ubuntu64_hw", 15:30:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:30:26 INFO - "branch": "fx-team", 15:30:26 INFO - "repo_path": "integration/fx-team", 15:30:26 INFO - "revision": "0c12d4229be0068eb1b9beb5064b800f12143f20", 15:30:26 INFO - "stage_platform": "linux64", 15:30:26 INFO - "builduid": "9a139e8575a14d5496caaa0449265b40", 15:30:26 INFO - "slavebuilddir": "test" 15:30:26 INFO - } 15:30:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:30:26 INFO - Running post-action listener: _resource_record_post_action 15:30:26 INFO - ##### 15:30:26 INFO - ##### Running download-and-extract step. 15:30:26 INFO - ##### 15:30:26 INFO - Running pre-action listener: _resource_record_pre_action 15:30:26 INFO - Running main action method: download_and_extract 15:30:26 INFO - mkdir: /builds/slave/test/build/tests 15:30:26 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')]} 15:30:26 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:30:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json 15:30:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json 15:30:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:30:28 INFO - Downloaded 1302 bytes. 15:30:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:30:28 INFO - Using the following test package requirements: 15:30:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:30:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:28 INFO - u'jsshell-linux-x86_64.zip'], 15:30:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:30:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:30:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:30:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:30:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:30:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:30:28 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')]} 15:30:28 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:29 INFO - Downloaded 21943082 bytes. 15:30:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:30:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:30:30 INFO - Return code: 0 15:30:30 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 15:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:30 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:32 INFO - Downloaded 21943082 bytes. 15:30:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:30:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:30:33 INFO - Return code: 0 15:30:33 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')]} 15:30:33 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:34 INFO - Downloaded 11132270 bytes. 15:30:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 15:30:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:30:34 INFO - Return code: 0 15:30:34 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')]} 15:30:34 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:36 INFO - Downloaded 53334623 bytes. 15:30:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:36 INFO - mkdir: /builds/slave/test/properties 15:30:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:36 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:36 INFO - Contents: 15:30:36 INFO - build_url:https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:36 INFO - Running post-action listener: _resource_record_post_action 15:30:36 INFO - Running post-action listener: set_extra_try_arguments 15:30:36 INFO - ##### 15:30:36 INFO - ##### Running populate-webroot step. 15:30:36 INFO - ##### 15:30:36 INFO - Running pre-action listener: _resource_record_pre_action 15:30:36 INFO - Running main action method: populate_webroot 15:30:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:36 INFO - '--tppagecycles', 15:30:36 INFO - '7'], 15:30:36 INFO - 'tests': ['tsvgm']}}, 15:30:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:30:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:30:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:30:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:30:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'tests': ['damp', 'tps']}, 15:30:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['damp', 'tps']}, 15:30:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:30:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:36 INFO - 'other': {'tests': ['a11yr', 15:30:36 INFO - 'ts_paint', 15:30:36 INFO - 'tpaint', 15:30:36 INFO - 'sessionrestore', 15:30:36 INFO - 'sessionrestore_no_auto_restore']}, 15:30:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['a11yr', 15:30:36 INFO - 'ts_paint', 15:30:36 INFO - 'tpaint', 15:30:36 INFO - 'sessionrestore', 15:30:36 INFO - 'sessionrestore_no_auto_restore']}, 15:30:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['a11yr', 15:30:36 INFO - 'ts_paint', 15:30:36 INFO - 'tpaint', 15:30:36 INFO - 'sessionrestore', 15:30:36 INFO - 'sessionrestore_no_auto_restore']}, 15:30:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['a11yr', 15:30:36 INFO - 'ts_paint', 15:30:36 INFO - 'tpaint', 15:30:36 INFO - 'sessionrestore', 15:30:36 INFO - 'sessionrestore_no_auto_restore']}, 15:30:36 INFO - 'other_l64': {'tests': ['a11yr', 15:30:36 INFO - 'ts_paint', 15:30:36 INFO - 'tpaint', 15:30:36 INFO - 'sessionrestore', 15:30:36 INFO - 'sessionrestore_no_auto_restore']}, 15:30:36 INFO - 'other_nol64': {'tests': ['a11yr', 15:30:36 INFO - 'ts_paint', 15:30:36 INFO - 'tpaint', 15:30:36 INFO - 'sessionrestore', 15:30:36 INFO - 'sessionrestore_no_auto_restore']}, 15:30:36 INFO - 'svgr': {'tests': ['tsvgx', 15:30:36 INFO - 'tsvgr_opacity', 15:30:36 INFO - 'tart', 15:30:36 INFO - 'tscrollx', 15:30:36 INFO - 'cart']}, 15:30:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['tsvgx', 15:30:36 INFO - 'tsvgr_opacity', 15:30:36 INFO - 'tart', 15:30:36 INFO - 'tscrollx', 15:30:36 INFO - 'cart']}, 15:30:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'tests': ['tp5o']}, 15:30:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'talos_options': ['--e10s'], 15:30:36 INFO - 'tests': ['tp5o']}, 15:30:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'talos_options': ['--xperf_path', 15:30:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:36 INFO - 'tests': ['tp5n']}, 15:30:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:36 INFO - 'talos_options': ['--e10s', 15:30:36 INFO - '--xperf_path', 15:30:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:36 INFO - 'tests': ['tp5n']}}, 15:30:36 INFO - 'talos.zip': {'path': '', 15:30:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:36 INFO - Running post-action listener: _resource_record_post_action 15:30:36 INFO - ##### 15:30:36 INFO - ##### Running create-virtualenv step. 15:30:36 INFO - ##### 15:30:36 INFO - Running pre-action listener: _resource_record_pre_action 15:30:36 INFO - Running main action method: create_virtualenv 15:30:36 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:36 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 15:30:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:36 INFO - Using real prefix '/usr' 15:30:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:38 INFO - Installing pip.................done. 15:30:38 INFO - Return code: 0 15:30:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:38 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:38 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 15:30:38 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 15:30:38 INFO - Using env: {'DISPLAY': ':0', 15:30:38 INFO - 'HOME': '/home/cltbld', 15:30:38 INFO - 'LANG': 'en_US.UTF-8', 15:30:38 INFO - 'LANGUAGE': 'en_US:en', 15:30:38 INFO - 'LOGNAME': 'cltbld', 15:30:38 INFO - 'MAIL': '/var/mail/cltbld', 15:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:38 INFO - 'MOZ_NO_REMOTE': '1', 15:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:38 INFO - 'NO_EM_RESTART': '1', 15:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:38 INFO - 'PWD': '/builds/slave/test', 15:30:38 INFO - 'SHELL': '/bin/bash', 15:30:38 INFO - 'SHLVL': '1', 15:30:38 INFO - 'TERM': 'linux', 15:30:38 INFO - 'TMOUT': '86400', 15:30:38 INFO - 'USER': 'cltbld', 15:30:38 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:38 INFO - '_': '/tools/buildbot/bin/python'} 15:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:38 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 15:30:38 INFO - Cleaning up... 15:30:38 INFO - Return code: 0 15:30:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:38 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:38 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 15:30:38 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 15:30:38 INFO - Using env: {'DISPLAY': ':0', 15:30:38 INFO - 'HOME': '/home/cltbld', 15:30:38 INFO - 'LANG': 'en_US.UTF-8', 15:30:38 INFO - 'LANGUAGE': 'en_US:en', 15:30:38 INFO - 'LOGNAME': 'cltbld', 15:30:38 INFO - 'MAIL': '/var/mail/cltbld', 15:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:38 INFO - 'MOZ_NO_REMOTE': '1', 15:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:38 INFO - 'NO_EM_RESTART': '1', 15:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:38 INFO - 'PWD': '/builds/slave/test', 15:30:38 INFO - 'SHELL': '/bin/bash', 15:30:38 INFO - 'SHLVL': '1', 15:30:38 INFO - 'TERM': 'linux', 15:30:38 INFO - 'TMOUT': '86400', 15:30:38 INFO - 'USER': 'cltbld', 15:30:38 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:38 INFO - '_': '/tools/buildbot/bin/python'} 15:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:39 INFO - Downloading/unpacking psutil>=0.7.1 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:30:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:30:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:40 INFO - Installing collected packages: psutil 15:30:40 INFO - Running setup.py install for psutil 15:30:40 INFO - building 'psutil._psutil_linux' extension 15:30:40 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 15:30:41 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 15:30:41 INFO - building 'psutil._psutil_posix' extension 15:30:41 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 15:30:41 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 15:30:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:41 INFO - Successfully installed psutil 15:30:41 INFO - Cleaning up... 15:30:41 INFO - Return code: 0 15:30:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:30:41 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')]} 15:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:41 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')]} 15:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:41 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:41 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 15:30:41 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 15:30:41 INFO - Using env: {'DISPLAY': ':0', 15:30:41 INFO - 'HOME': '/home/cltbld', 15:30:41 INFO - 'LANG': 'en_US.UTF-8', 15:30:41 INFO - 'LANGUAGE': 'en_US:en', 15:30:41 INFO - 'LOGNAME': 'cltbld', 15:30:41 INFO - 'MAIL': '/var/mail/cltbld', 15:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:41 INFO - 'MOZ_NO_REMOTE': '1', 15:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:41 INFO - 'NO_EM_RESTART': '1', 15:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:41 INFO - 'PWD': '/builds/slave/test', 15:30:41 INFO - 'SHELL': '/bin/bash', 15:30:41 INFO - 'SHLVL': '1', 15:30:41 INFO - 'TERM': 'linux', 15:30:41 INFO - 'TMOUT': '86400', 15:30:41 INFO - 'USER': 'cltbld', 15:30:41 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:41 INFO - '_': '/tools/buildbot/bin/python'} 15:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:30:41 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 15:30:41 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 15:30:41 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 15:30:41 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 15:30:41 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 15:30:41 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 15:30:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:30:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:30:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:30:43 INFO - Installing collected packages: mozsystemmonitor 15:30:43 INFO - Running setup.py install for mozsystemmonitor 15:30:43 INFO - Successfully installed mozsystemmonitor 15:30:43 INFO - Cleaning up... 15:30:43 INFO - Return code: 0 15:30:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:30:43 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')]} 15:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:43 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')]} 15:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:43 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:43 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 15:30:43 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 15:30:43 INFO - Using env: {'DISPLAY': ':0', 15:30:43 INFO - 'HOME': '/home/cltbld', 15:30:43 INFO - 'LANG': 'en_US.UTF-8', 15:30:43 INFO - 'LANGUAGE': 'en_US:en', 15:30:43 INFO - 'LOGNAME': 'cltbld', 15:30:43 INFO - 'MAIL': '/var/mail/cltbld', 15:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:43 INFO - 'MOZ_NO_REMOTE': '1', 15:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:43 INFO - 'NO_EM_RESTART': '1', 15:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:43 INFO - 'PWD': '/builds/slave/test', 15:30:43 INFO - 'SHELL': '/bin/bash', 15:30:43 INFO - 'SHLVL': '1', 15:30:43 INFO - 'TERM': 'linux', 15:30:43 INFO - 'TMOUT': '86400', 15:30:43 INFO - 'USER': 'cltbld', 15:30:43 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:43 INFO - '_': '/tools/buildbot/bin/python'} 15:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:43 INFO - Downloading/unpacking blobuploader==1.2.4 15:30:43 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 15:30:43 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 15:30:43 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 15:30:43 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 15:30:43 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 15:30:43 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 15:30:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:30:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:30:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:30:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:46 INFO - Downloading docopt-0.6.1.tar.gz 15:30:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:30:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:30:46 INFO - Running setup.py install for blobuploader 15:30:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:30:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:30:46 INFO - Running setup.py install for requests 15:30:46 INFO - Running setup.py install for docopt 15:30:46 INFO - Successfully installed blobuploader requests docopt 15:30:46 INFO - Cleaning up... 15:30:46 INFO - Return code: 0 15:30:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:46 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:46 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 15:30:46 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 15:30:46 INFO - Using env: {'DISPLAY': ':0', 15:30:46 INFO - 'HOME': '/home/cltbld', 15:30:46 INFO - 'LANG': 'en_US.UTF-8', 15:30:46 INFO - 'LANGUAGE': 'en_US:en', 15:30:46 INFO - 'LOGNAME': 'cltbld', 15:30:46 INFO - 'MAIL': '/var/mail/cltbld', 15:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:46 INFO - 'MOZ_NO_REMOTE': '1', 15:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:46 INFO - 'NO_EM_RESTART': '1', 15:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:46 INFO - 'PWD': '/builds/slave/test', 15:30:46 INFO - 'SHELL': '/bin/bash', 15:30:46 INFO - 'SHLVL': '1', 15:30:46 INFO - 'TERM': 'linux', 15:30:46 INFO - 'TMOUT': '86400', 15:30:46 INFO - 'USER': 'cltbld', 15:30:46 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:46 INFO - '_': '/tools/buildbot/bin/python'} 15:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:46 INFO - Running setup.py (path:/tmp/pip-2CAxOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:47 INFO - Running setup.py (path:/tmp/pip-cI0IR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:47 INFO - Running setup.py (path:/tmp/pip-dYooq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:47 INFO - Running setup.py (path:/tmp/pip-U2_75D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:47 INFO - Running setup.py (path:/tmp/pip-QEqDcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:47 INFO - Running setup.py (path:/tmp/pip-vzDspI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:47 INFO - Running setup.py (path:/tmp/pip-nbqFVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:47 INFO - Running setup.py (path:/tmp/pip-JjeKpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:47 INFO - Running setup.py (path:/tmp/pip-lh_0jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:47 INFO - Running setup.py (path:/tmp/pip-4lXGhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:47 INFO - Running setup.py (path:/tmp/pip-8_4X4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:47 INFO - Running setup.py (path:/tmp/pip-xw2D29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:47 INFO - Running setup.py (path:/tmp/pip-4mU2pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:47 INFO - Running setup.py (path:/tmp/pip-kTRxZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:47 INFO - Running setup.py (path:/tmp/pip-EeGDcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:48 INFO - Running setup.py (path:/tmp/pip-Otp82J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:48 INFO - Running setup.py (path:/tmp/pip-sOzF6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:30:48 INFO - Running setup.py install for manifestparser 15:30:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:30:48 INFO - Running setup.py install for mozcrash 15:30:48 INFO - Running setup.py install for mozdebug 15:30:48 INFO - Running setup.py install for mozdevice 15:30:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:30:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:30:48 INFO - Running setup.py install for mozfile 15:30:48 INFO - Running setup.py install for mozhttpd 15:30:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:30:48 INFO - Running setup.py install for mozinfo 15:30:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:30:48 INFO - Running setup.py install for mozInstall 15:30:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Running setup.py install for mozleak 15:30:49 INFO - Running setup.py install for mozlog 15:30:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Running setup.py install for moznetwork 15:30:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Running setup.py install for mozprocess 15:30:49 INFO - Running setup.py install for mozprofile 15:30:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Running setup.py install for mozrunner 15:30:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Running setup.py install for mozscreenshot 15:30:49 INFO - Running setup.py install for moztest 15:30:49 INFO - Running setup.py install for mozversion 15:30:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:30:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:30:49 INFO - Cleaning up... 15:30:49 INFO - Return code: 0 15:30:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:49 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')]} 15:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:49 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')]} 15:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:49 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:49 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 15:30:49 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 15:30:50 INFO - Using env: {'DISPLAY': ':0', 15:30:50 INFO - 'HOME': '/home/cltbld', 15:30:50 INFO - 'LANG': 'en_US.UTF-8', 15:30:50 INFO - 'LANGUAGE': 'en_US:en', 15:30:50 INFO - 'LOGNAME': 'cltbld', 15:30:50 INFO - 'MAIL': '/var/mail/cltbld', 15:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:50 INFO - 'MOZ_NO_REMOTE': '1', 15:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:50 INFO - 'NO_EM_RESTART': '1', 15:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:50 INFO - 'PWD': '/builds/slave/test', 15:30:50 INFO - 'SHELL': '/bin/bash', 15:30:50 INFO - 'SHLVL': '1', 15:30:50 INFO - 'TERM': 'linux', 15:30:50 INFO - 'TMOUT': '86400', 15:30:50 INFO - 'USER': 'cltbld', 15:30:50 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:50 INFO - '_': '/tools/buildbot/bin/python'} 15:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:50 INFO - Running setup.py (path:/tmp/pip-PYUbBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:50 INFO - Running setup.py (path:/tmp/pip-OvvZLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:50 INFO - Running setup.py (path:/tmp/pip-az8OMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:50 INFO - Running setup.py (path:/tmp/pip-K2z39j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:50 INFO - Running setup.py (path:/tmp/pip-7fHjrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:50 INFO - Running setup.py (path:/tmp/pip-PuOO5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:50 INFO - Running setup.py (path:/tmp/pip-p3iHCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:50 INFO - Running setup.py (path:/tmp/pip-smIS4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:50 INFO - Running setup.py (path:/tmp/pip-Eb2Apf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:50 INFO - Running setup.py (path:/tmp/pip-bHCH5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:50 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)) 15:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:50 INFO - Running setup.py (path:/tmp/pip-sE6ThL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:51 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)) 15:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:51 INFO - Running setup.py (path:/tmp/pip-zrMDyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:51 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)) 15:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:51 INFO - Running setup.py (path:/tmp/pip-XPwjO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:51 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)) 15:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:51 INFO - Running setup.py (path:/tmp/pip-kwbntI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:51 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)) 15:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:51 INFO - Running setup.py (path:/tmp/pip-teFjhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:51 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)) 15:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:51 INFO - Running setup.py (path:/tmp/pip-lxsWWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:51 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)) 15:30:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:51 INFO - Running setup.py (path:/tmp/pip-y40MIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:51 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)) 15:30:51 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)) 15:30:51 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)) 15:30:51 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)) 15:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:30:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:30:51 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 15:30:51 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 15:30:51 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 15:30:51 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 15:30:51 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 15:30:51 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 15:30:53 INFO - Downloading blessings-1.5.1.tar.gz 15:30:53 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 15:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:30:53 INFO - Installing collected packages: blessings 15:30:53 INFO - Running setup.py install for blessings 15:30:53 INFO - Successfully installed blessings 15:30:53 INFO - Cleaning up... 15:30:53 INFO - Return code: 0 15:30:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:30:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:30:53 INFO - Reading from file tmpfile_stdout 15:30:53 INFO - Current package versions: 15:30:53 INFO - argparse == 1.2.1 15:30:53 INFO - blessings == 1.5.1 15:30:53 INFO - blobuploader == 1.2.4 15:30:53 INFO - docopt == 0.6.1 15:30:53 INFO - manifestparser == 1.1 15:30:53 INFO - mozInstall == 1.12 15:30:53 INFO - mozcrash == 0.16 15:30:53 INFO - mozdebug == 0.1 15:30:53 INFO - mozdevice == 0.47 15:30:53 INFO - mozfile == 1.2 15:30:53 INFO - mozhttpd == 0.7 15:30:53 INFO - mozinfo == 0.9 15:30:53 INFO - mozleak == 0.1 15:30:53 INFO - mozlog == 3.1 15:30:53 INFO - moznetwork == 0.27 15:30:53 INFO - mozprocess == 0.22 15:30:53 INFO - mozprofile == 0.28 15:30:53 INFO - mozrunner == 6.11 15:30:53 INFO - mozscreenshot == 0.1 15:30:53 INFO - mozsystemmonitor == 0.0 15:30:53 INFO - moztest == 0.7 15:30:53 INFO - mozversion == 1.4 15:30:53 INFO - psutil == 3.1.1 15:30:53 INFO - requests == 1.2.3 15:30:53 INFO - wsgiref == 0.1.2 15:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:53 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:53 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 15:30:53 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 15:30:53 INFO - Using env: {'DISPLAY': ':0', 15:30:53 INFO - 'HOME': '/home/cltbld', 15:30:53 INFO - 'LANG': 'en_US.UTF-8', 15:30:53 INFO - 'LANGUAGE': 'en_US:en', 15:30:53 INFO - 'LOGNAME': 'cltbld', 15:30:53 INFO - 'MAIL': '/var/mail/cltbld', 15:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:53 INFO - 'MOZ_NO_REMOTE': '1', 15:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:53 INFO - 'NO_EM_RESTART': '1', 15:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:53 INFO - 'PWD': '/builds/slave/test', 15:30:53 INFO - 'SHELL': '/bin/bash', 15:30:53 INFO - 'SHLVL': '1', 15:30:53 INFO - 'TERM': 'linux', 15:30:53 INFO - 'TMOUT': '86400', 15:30:53 INFO - 'USER': 'cltbld', 15:30:53 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:53 INFO - '_': '/tools/buildbot/bin/python'} 15:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 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)) 15:30:53 INFO - Cleaning up... 15:30:53 INFO - Return code: 0 15:30:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:53 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:53 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 15:30:53 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 15:30:53 INFO - Using env: {'DISPLAY': ':0', 15:30:53 INFO - 'HOME': '/home/cltbld', 15:30:53 INFO - 'LANG': 'en_US.UTF-8', 15:30:53 INFO - 'LANGUAGE': 'en_US:en', 15:30:53 INFO - 'LOGNAME': 'cltbld', 15:30:53 INFO - 'MAIL': '/var/mail/cltbld', 15:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:53 INFO - 'MOZ_NO_REMOTE': '1', 15:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:53 INFO - 'NO_EM_RESTART': '1', 15:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:53 INFO - 'PWD': '/builds/slave/test', 15:30:53 INFO - 'SHELL': '/bin/bash', 15:30:53 INFO - 'SHLVL': '1', 15:30:53 INFO - 'TERM': 'linux', 15:30:53 INFO - 'TMOUT': '86400', 15:30:53 INFO - 'USER': 'cltbld', 15:30:53 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:53 INFO - '_': '/tools/buildbot/bin/python'} 15:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:54 INFO - Downloading/unpacking jsonschema 15:30:54 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 15:30:54 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 15:30:54 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 15:30:54 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 15:30:54 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 15:30:54 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 15:30:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:30:55 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 15:30:55 INFO - Downloading/unpacking functools32 (from jsonschema) 15:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:30:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:30:56 INFO - warning: no files found matching '*.txt' 15:30:56 INFO - no previously-included directories found matching 'build' 15:30:56 INFO - no previously-included directories found matching 'dist' 15:30:56 INFO - no previously-included directories found matching '.git*' 15:30:56 INFO - Installing collected packages: jsonschema, functools32 15:30:56 INFO - Running setup.py install for functools32 15:30:56 INFO - warning: no files found matching '*.txt' 15:30:56 INFO - no previously-included directories found matching 'build' 15:30:56 INFO - no previously-included directories found matching 'dist' 15:30:56 INFO - no previously-included directories found matching '.git*' 15:30:56 INFO - Successfully installed jsonschema functools32 15:30:56 INFO - Cleaning up... 15:30:56 INFO - Return code: 0 15:30:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:30:56 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')]} 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:56 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')]} 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:56 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 0x7f0c2c0a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e95dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', '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 15:30:56 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 15:30:56 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 15:30:56 INFO - Using env: {'DISPLAY': ':0', 15:30:56 INFO - 'HOME': '/home/cltbld', 15:30:56 INFO - 'LANG': 'en_US.UTF-8', 15:30:56 INFO - 'LANGUAGE': 'en_US:en', 15:30:56 INFO - 'LOGNAME': 'cltbld', 15:30:56 INFO - 'MAIL': '/var/mail/cltbld', 15:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:56 INFO - 'MOZ_NO_REMOTE': '1', 15:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:56 INFO - 'NO_EM_RESTART': '1', 15:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:56 INFO - 'PWD': '/builds/slave/test', 15:30:56 INFO - 'SHELL': '/bin/bash', 15:30:56 INFO - 'SHLVL': '1', 15:30:56 INFO - 'TERM': 'linux', 15:30:56 INFO - 'TMOUT': '86400', 15:30:56 INFO - 'USER': 'cltbld', 15:30:56 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:56 INFO - '_': '/tools/buildbot/bin/python'} 15:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:56 INFO - Downloading/unpacking flake8 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:30:58 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 15:30:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:30:58 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 15:30:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 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 15:30:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:30:58 INFO - no previously-included directories found matching 'docs/_build' 15:30:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:30:58 INFO - Running setup.py install for pep8 15:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:30:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:30:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:30:58 INFO - no previously-included directories found matching 'docs/_build' 15:30:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:30:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:30:58 INFO - Cleaning up... 15:30:59 INFO - Return code: 0 15:30:59 INFO - Running post-action listener: _resource_record_post_action 15:30:59 INFO - Running post-action listener: _start_resource_monitoring 15:30:59 INFO - Starting resource monitoring. 15:30:59 INFO - ##### 15:30:59 INFO - ##### Running install step. 15:30:59 INFO - ##### 15:30:59 INFO - Running pre-action listener: _resource_record_pre_action 15:30:59 INFO - Running main action method: install 15:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:30:59 INFO - Reading from file tmpfile_stdout 15:30:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:30:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:30:59 INFO - Reading from file tmpfile_stdout 15:30:59 INFO - Output received: 15:30:59 INFO - Usage: mozinstall [options] installer 15:30:59 INFO - Options: 15:30:59 INFO - -h, --help show this help message and exit 15:30:59 INFO - -d DEST, --destination=DEST 15:30:59 INFO - Directory to install application into. [default: 15:30:59 INFO - "/builds/slave/test"] 15:30:59 INFO - --app=APP Application being installed. [default: firefox] 15:30:59 INFO - mkdir: /builds/slave/test/build/application 15:30:59 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'] 15:30:59 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 15:31:14 INFO - Reading from file tmpfile_stdout 15:31:14 INFO - Output received: 15:31:14 INFO - /builds/slave/test/build/application/firefox/firefox 15:31:14 INFO - Running post-action listener: _resource_record_post_action 15:31:14 INFO - ##### 15:31:14 INFO - ##### Running run-tests step. 15:31:14 INFO - ##### 15:31:14 INFO - Running pre-action listener: _resource_record_pre_action 15:31:14 INFO - Running main action method: run_tests 15:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:14 INFO - Python 2.7.3 15:31:14 INFO - Return code: 0 15:31:14 INFO - grabbing minidump binary from tooltool 15:31:14 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')]} 15:31:14 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 0x1f283d0>, '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 0x1e93ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e94360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:14 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 15:31:14 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 15:31:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:14 INFO - Return code: 0 15:31:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:31:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:31:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:31:15 INFO - Return code: 0 15:31:15 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/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:31:15 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/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 15:31:15 INFO - Using env: {'DISPLAY': ':0', 15:31:15 INFO - 'HOME': '/home/cltbld', 15:31:15 INFO - 'LANG': 'en_US.UTF-8', 15:31:15 INFO - 'LANGUAGE': 'en_US:en', 15:31:15 INFO - 'LOGNAME': 'cltbld', 15:31:15 INFO - 'MAIL': '/var/mail/cltbld', 15:31:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:15 INFO - 'MOZ_NO_REMOTE': '1', 15:31:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:15 INFO - 'NO_EM_RESTART': '1', 15:31:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:15 INFO - 'PWD': '/builds/slave/test', 15:31:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:15 INFO - 'SHELL': '/bin/bash', 15:31:15 INFO - 'SHLVL': '1', 15:31:15 INFO - 'TERM': 'linux', 15:31:15 INFO - 'TMOUT': '86400', 15:31:15 INFO - 'USER': 'cltbld', 15:31:15 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870', 15:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:15 INFO - '_': '/tools/buildbot/bin/python'} 15:31:15 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/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:31:16 INFO - mozversion application_buildid: 20151229144335 15:31:16 INFO - mozversion application_changeset: 0c12d4229be0068eb1b9beb5064b800f12143f20 15:31:16 INFO - mozversion application_display_name: Nightly 15:31:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:16 INFO - mozversion application_name: Firefox 15:31:16 INFO - mozversion application_remotingname: firefox 15:31:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:31:16 INFO - mozversion application_vendor: Mozilla 15:31:16 INFO - mozversion application_version: 46.0a1 15:31:16 INFO - mozversion platform_buildid: 20151229144335 15:31:16 INFO - mozversion platform_changeset: 0c12d4229be0068eb1b9beb5064b800f12143f20 15:31:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:31:16 INFO - mozversion platform_version: 46.0a1 15:31:16 INFO - using testdate: 1451431876 15:31:16 INFO - actual date: 1451431876 15:31:16 INFO - starting webserver on 'localhost:41018' 15:31:16 INFO - SUITE-START | Running 3 tests 15:31:16 INFO - TEST-START | dromaeo_css 15:31:16 INFO - operating with platform_type : linux_ 15:31:16 INFO - Initialising browser for dromaeo_css test... 15:31:16 INFO - TEST-INFO | started process 3664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI0i2HS/profile http://localhost:41018/getInfo.html) 15:31:22 INFO - PROCESS | 3664 | __metrics Screen width/height:1600/1200 15:31:22 INFO - PROCESS | 3664 | colorDepth:24 15:31:22 INFO - PROCESS | 3664 | Browser inner width/height: 1024/697 15:31:22 INFO - PROCESS | 3664 | __metrics 15:31:22 INFO - PROCESS | 3664 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:31:23 INFO - TEST-INFO | 3664: exit 0 15:31:23 INFO - Browser initialized. 15:31:23 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:23 INFO - TEST-INFO | started process 3796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI0i2HS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:35 INFO - PROCESS | 3796 | RSS: Main: 149626880 15:31:35 INFO - PROCESS | 3796 | 15:32:24 INFO - PROCESS | 3796 | 1451431944685 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] 15:34:36 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:41018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41018/tests/dromaeo/cssquery-ext.html) 15:34:37 INFO - PROCESS | 3796 | RSS: Main: 153436160 15:34:37 INFO - PROCESS | 3796 | 15:37:39 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:41018/tests/dromaeo/cssquery-ext.html (next: http://localhost:41018/tests/dromaeo/cssquery-jquery.html) 15:37:40 INFO - PROCESS | 3796 | RSS: Main: 153329664 15:37:40 INFO - PROCESS | 3796 | 15:40:42 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:41018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41018/tests/dromaeo/cssquery-mootools.html) 15:40:42 INFO - PROCESS | 3796 | RSS: Main: 152948736 15:40:42 INFO - PROCESS | 3796 | 15:43:44 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:41018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41018/tests/dromaeo/cssquery-prototype.html) 15:43:45 INFO - PROCESS | 3796 | RSS: Main: 152215552 15:43:45 INFO - PROCESS | 3796 | 15:46:47 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:41018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41018/tests/dromaeo/cssquery-yui.html) 15:46:48 INFO - PROCESS | 3796 | RSS: Main: 152915968 15:46:48 INFO - PROCESS | 3796 | 15:49:50 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:41018/tests/dromaeo/cssquery-yui.html (next: http://localhost:41018/tests/dromaeo/cssquery-dojo.html) 15:49:51 INFO - PROCESS | 3796 | RSS: Main: 155123712 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | __start_tp_report 15:49:51 INFO - PROCESS | 3796 | _x_x_mozilla_page_load 15:49:51 INFO - PROCESS | 3796 | _x_x_mozilla_page_load_details 15:49:51 INFO - PROCESS | 3796 | |i|pagename|runs| 15:49:51 INFO - PROCESS | 3796 | |0;dojo.html;2682.771964383028;2731.0987374166525;2769.487644785715;2776;2791.7627001704855;4564.246899261626;4757.310190022445;4778.139934811733;4780.282957556368;4809.158397280479;4687.437507499105;4693.5306469353045;4704.670673052888;4827.03459308138;4834.178189707749;4312.28847240205;4380.956190438103;4441.511433742286;4449.221386257408;4485.506594274627;4058.783709173313;4430.291153415455;4430.556944305576;4449.17690227309;4515.6613254005915;4215.051613386994;4325.416068830699;4425.137098265839;4454.754988475633;4469.173202957447;4289.871303860889;4294.076773493683;4296.033392486696;4296.291111966553;4296.935545966813;4354.085642015149;4358.433403657505;4398.648108151372;4401.229784787682;4437.822487100512;4553.931691024637;4563.9087218255445;4564.589186973155;4615.446146462446;4639.234526303156;4890.24201248807;4958.87602809929;4959.628027897886;5111.872203194913;5118.309028281172;5042.974785126087;5070.366204224472;5077.2637967494875;5087.440381558025;5120.92318615221;4715.151272770866;4717.2452407614965;4720.409948756405;4759.024399998027;4761.35721677576;5028.270900719375;5151.896962060738;5160.767765450564;5198.4801519847715;5265.315508983807;4928.112939670822;4946.4064312282035;4951.8514444566;4951.9752401237765;4961.355023846877;5022.547970682656;5043.067032598981;5044.2937988681615;5047.747612619354;5059.949400506021;4881.389826271716;4993.675411098267;5014.2979982802435;5073.847784566469;5124.256982737482;4970.279309500174;4983.27742477346;4997.775100120431;5002.399712034579;5022.347094877716;4131.752094874257;4253.659707223414;4267.679924005712;4274.123804620045;4320.913581728348;3702.7037836972977;3735.6451137141926;3771.660550550409;3794.8671796487542;3814.9618503815163;4367.890802729958;4408.162449134654;4409.4488188976375;4413.124422120586;4465.352523884018;4917.360743103445;5053.343065401475;5090.643654944119;5108;5147.176451767699;4401.867943961686;4447.266201076851;4451.710638808467;4457.442819647544;4483.058557702919;4539.568740969668;4578.519255478193;4585.6102231310715;4610.308453731967;4639.048994956026;4641.6286697064825;4756.357891684716;4779.593734532604;4860.246661767432;4915.68048076881;5150.768215430389;5166.767495462638;5171.276021357088;5176.792928282826;5183.81856635016;4878.975605121952;4901.877453063702;4902.2156454967035;4911.8280860169725;4950.727709975986;4826.372571565674;4928.975355123202;5048.974755126201;5083.542481176712;5151.845444636667;5004.624653150955;5054.418741844588;5067.467915868928;5068.949310506848;5107.978404319077;4866.975665121652;4868.659193856396;4883.096627123993;4900.387451568554;4922.704637721748;4747;4878.512148785093;4908.92636610444;4987.625928055338;5037.622178336713;4784.760761961818;4798.136335459651;4809.759512024455;4813.302071199727;4891.217405215149;4853.0779151961015;5020.648554601143;5025.39695236574;5027.84916452507;5063.8480845574695;4805.7597120144555;4886.975565122151;4947.060058588857;4950.752462376939;5003.199488082035 15:49:51 INFO - PROCESS | 3796 | |1;ext.html;465.3345715626655;503.3707865168538;507.2138185811993;512.4184051102;539.8731298144933;32894.506582401256;33573.66426335736;33699.83150084252;33711.32577348452;33735.493967590504;36793.81603091981;37434.62565374345;37439.43840842389;37502.624973750324;37527.437088443694;7408.96295518523;7721.72973945912;7773.261540153705;7787.805304867367;7792;7581.2039735827775;7697.191794861543;7732.729354472594;7883;7909;7860.724874629389;7864.803379915491;7869.331106855924;7927.920720792776;7930.286274235317;7363.77908662741;7364.926350736504;7379.1513975892385;7388.852222955537;7414.184439711627;7741.7677469676;7891.2897839194175;7891.289783919475;7894.763157105296;7903.0911445183965;35185.64814351875;35665.46501802475;35773.46339804905;35775.82112089449;36085.278294434225;2660.6674165729282;2722.891084356623;2769.2661444717164;2800.1179628416985;3177.5710279112254;27864.442711145664;28654.71345286562;28708.425831483462;28729.425411491655;28959.84160633572;3287.605487341534;3323.667633236681;3327.617324007746;3351.1957130288556;3400.7619466637343;160350;160528;160533;160732;161163;53320;53676.73161634167;53717.73141134269;53940.19089713658;53972;50276.24585631218;51604;59608.40391596115;60576;61099;11942.462589183508;12127.818082728767;12206.633800985985;12246.755064898653;12256.203346782431;8044.557549334842;8073.152319006537;8073.83852322962;8096.149904259968;8128.268455839003;18170.18234179465;18417.81582184188;18488;18507.35224267171;18518.629627407376;7004.194517630538;7275.308845659654;7361.153467351216;7394.334509894028;7485.513441626277;822.333909533268;888.8711136885115;899.6266549382065;929.7350255177242;978.6379039755336;23496.177633782736;23694.644580331307;25987.22038338853;26692;26879.193624191306;871.6034204437093;902.9051949545203;904.3398319226869;939.0421769794771;1000.8949060348705;12222.388880556115;12463.563775267821;12479.56321528742;12519.311437871005;12526.185797923106;264781;268880;271958;272844;274110;45574.54425455703;45593.544064559595;45773.54226457759;45840;45859.3121103177;1103.9448027598587;1131.3042478875598;1132.1565433751907;1188.7979043562616;1201.7836789377996;23886.64170037416;24003;24106.156284529956;24133;24368.63447048331;37593.060173495884;38038;38110.237795244495;38210.426843597925;38292;258294;258421;259904;260494;260774;28300.85849570739;29065;29189.270268243465;29510.704892950795;29555.261118472212;33672.49491257584;33999.32001359909;34028.3194336107;34669.826650867595;34874.47688284729;28774.42451151007;29225.7077429223;29320.413591727618;29435;29904.102876913727;30584.388312234074;31132;31565.21086972752;31846;32020.35959280755;32808;33316.66683333136;33485.33029339448;33680.49479257764;33737.15657108592;27577.58633620457;28714.98995070325;30583.847080765343;30833.845830770704;31029;21750.49732856407;21860.89069554642;21902;22042;22107 15:49:51 INFO - PROCESS | 3796 | |2;jquery.html;333.1537893749875;337.5004992610936;338.18328736102313;338.7273245037745;340.20052875741993;14634.853651463482;15023.549293521199;15569.922150389231;15705.450309239179;16166.919165404186;9036.68371606994;9262.953685231581;9361.906380936205;9918.504074796267;9944.254180936441;4420.9115817683705;4505.819767209307;4532.184206842783;4545.6136228420455;4554.157480866033;4449.621782148522;4520.615747661436;4561.885952851172;4562.9771851140695;4574.794134263966;4554.590086892179;4560.315952607119;4725.432948046222;4863.732494712789;4896.46138924718;4832.323474713543;4840.370751802261;4848.5151484851585;4868.610511159134;4876.731779752112;4561.384213131251;4709.2229782085915;4733.171694953369;4735.621150307967;4740.265258884879;10798;10811.891881081167;10821.83767243492;12766.17019893704;17214.741778873326;1589.3324803582523;1595.7845690831705;1606.9598260043476;1710.9230084646222;1755.0522717732408;8369.204925532065;8447.915520844774;8463.74608761738;12051.216670916363;12810.871891281155;1667.4247384652276;1683.8989660620402;1709.820468850765;1751.7372394140853;1764.2325588369101;53768.73115634436;56748.71625641887;57609.711951439975;57625;58136;9347.626094956262;9796.510174491246;9803;9906.356086854332;9918.80162396748;12446.688832779253;12533.811992820116;12590.622281331574;12605.87394126047;12618.558350457874;6237.033259844731;6255.655938923312;6394.072859435356;6446.613203207822;6582.111414959015;5631.4087020863035;5645.830625081254;5658.264425624642;5718.485336319751;5723.828285151452;3887.5140607424073;3979.144483935968;4126.504819421629;4161.97919010403;4217.578242175758;1656.403694669918;1707.4450803488917;1713.400309891528;1754.6841568517789;1812.3837895115723;376.22309929994475;384.2181161336666;389.9863504777319;390.1475276520811;396.29459561979724;9162.221211197122;9465;9534.95232523833;9743.853842192373;9794.412335259907;377.3660250778718;377.5069599733104;383.71029872446127;385.5450568329342;392.1079544037338;5322.654027488278;5337.599680024014;5349.22436246742;5377.3816011159215;5411.026015317202;330618.77524899214;332607;332686;335251;338089;60480.69759651174;62543.374566254664;62937.68531157407;62984.68507657432;63356;436.3629101511765;442.52428639212974;443.19781196034637;443.38812438834844;445.7592899834053;9410.200132988499;9547.952260238655;9552.761180970254;9574.281928855504;9695.418274903528;32403.67596324101;34035.82982085074;34811;34999.30001399907;35110.12224694403;41789.79105104455;43324.56675433205;43729.56270437255;44219.77890110529;45465.54534454613;7620.123685775985;8743.606537705946;8868.201861832466;8868.423552469327;8870.15733505316;11485.368304743319;16275.186240688156;16339.346426142822;16467.835321647108;16734.748978765572;12964.286964217059;13347;13471.12437691547;13624.18254904709;13749.450021999008;13107.148035378052;13412.731745365234;13647.79528307096;13723.1079979801;13928.51250206238;13198.472061117447;13515.797263040866;13652.453901843815;13666.86333136656;13686.315684215948;8283.08886022525;8380.664773408995;8455.069942306465;8463.53450560225;8487.957560212159;8806.64773409082;12797.42411591462;13699;13738.65653358634;13778.65553361174 15:49:51 INFO - PROCESS | 3796 | |3;mootools.html;1369.972600547989;1382.9999999999998;1474.9041312314698;1671.615528428462;1685.4269548353557;7003.964980175098;7030.156381234259;7080.398166155876;7090.078289822322;7126.643667816601;7015.263397343282;7082.043924070249;7109.822254443641;7117.359437650611;7190.029346038284;2087.4468265909545;2120.830333573318;2123.4160605833363;2124.0866427436194;2128.3934078787547;2105.315772373977;2117.6717608770587;2126.2876936226307;2132.9040193191267;2137.8824164670937;1735.7656716343322;1786.4997800615783;2068;2069.0896005757418;2096.2558291806417;2063.288165582864;2068.2864411777987;2069.689546568027;2071.4200023993308;2075.7716651168357;2057.9176832926814;2070.2960993262363;2134.1463414634113;2136;2152.752433470155;7018.824529386755;7042.0493233413345;7050.083489146378;7084.362407383309;7122.323379278961;4180.644645205161;4258.61672449481;4280.4863416390235;4292.613664770186;4304.182205380967;2772.4039331543613;2784.303924018995;2904.8838046478118;2913.766898648103;2941.1176647006027;863.3956230638578;887.4231749362966;908.2733812949614;919.3610440743686;922.5064590444081;9642.662506812228;9701.417914925127;9721.076497732774;9729.659461918869;9757.316987810857;3713.925721485555;3762.567304759933;3837.57786643469;3934.409838524244;3961.346377847623;7835.294823465915;7869.645865936047;7871.803204919923;7876.330511906437;7881.842363152819;4212.220739163204;4217.810198541073;4227.577242275809;4230.2174097792;4231.386448964944;3843.0776613612534;3868.1103346230525;3877.495925529663;3879.1078052047624;3894.045958740127;3149.0710240479116;3198.552202691625;3219.5492631031675;3227.128675257667;3230.8869189578254;960.5629438605557;961.0821665309612;963.0610155098863;966.2221911361281;968.8740463739668;753.7437271327775;772.3743767548303;813.6623301329881;861.5046348349724;934.8083642853198;6380.202474690664;6507.869842603216;6508.674566271668;6510.21877374718;6529.967350163219;524.4336116993637;532.8880935003615;534.9117395629755;535.5447869311055;687.6871023684212;4869.415670119608;4912.557869791736;4966.553010229024;4975.875603109879;4980.5019498049905;8161.387895907831;8278.751637450887;8619.569021548898;8644.265237454887;8644.783880402914;8432.915670843337;8454.492730436194;8509.234168924826;8519.446235994641;8533.786655333543;6588.835279117964;6731.730730770714;6754.223264324567;6755.527113102134;6788.5926844388505;6374.458171055512;6394.072859435263;6412.326705695835;6413.903791443226;6433.260175079926;7464.962675186806;7548.056492938383;7659.540427574363;7716.074071111502;7740.148583655906;7628.580428076287;7767.417443691633;7795.103563090091;7895.921040789519;7938;6028.728707208098;6064.151018857276;6064.211652485325;6066.3630318815885;6071.119687645355;6639.800805975829;6795.830104247433;6796.184457865088;6799.150106236721;6799.422049125682;6455.644939528371;6479.935200647933;6514.120593719787;6537.1501704778075;6601.603903765789;5371.140617501181;5383.08487557124;6066.514678825595;6248.062790581449;6314.400131987454;6357.205349331333;6404.423601875854;6414.358564143548;6432.292447830641;6447.70985305653;5760.539156867357;5856.209411729362;5868.38381969887;5870.207521984648;5879.05935050407;5877.324107727495;5934.732937017759;5945.346011938596;5946.048632218824;5960.76156953717 15:49:51 INFO - PROCESS | 3796 | |4;prototype.html;308.4802108447266;312.1680720878858;318.51585589903345;320.71393711218036;322.36654972978107;5410.729463526827;5499;5568.443155684429;5607.6074674772735;5618.5786066045;5382.138857782756;5521.116621340586;5543.168524721294;5550.389457159719;5550.750216240269;4296.48442186938;4308.052228509723;4317.827286908519;4320.135972805436;4322.157179350036;4304.720193187449;4309.396684464162;4320.438343015419;4324.329728892011;4339.609435150835;4056.634902858742;4176.269152898246;4284.507281662618;4293.248681480728;4295.613394794468;4172.749635021908;4179.205950869356;4183.91632167355;4184.267753143203;4189.560096189902;3674.430463278196;3674.503941967827;3674.8530058797883;3677.7241706871823;3680.9263814723554;5154;5246.737663116829;5250.6324557281005;5257.185136303879;5258.658187217857;4878.707277563322;4894.119058569456;4897.314375987365;4898.044881248158;4898.657094003421;5817.825465236049;5820.82537523875;5865.442782935615;5869.735861886225;5871.442212989759;3833.674137698299;3982.980085099585;4006.2788698034633;4012.578679238667;4016.9196616067516;6099.878002439971;6116.724747386334;6138.202033735586;6156.415140561639;6168.568200226031;4151.4395556599475;4153.813078411479;4160.54234034256;4165.500139983161;4169.291220492523;4231.851885184004;4233.449651545279;4237.110206856533;4238.385434112098;4240.406343111967;4666.789994450258;4839.056384005085;4847.079054979543;4849.102915960559;4865.7323847188745;5747.166660834156;5800.622959507618;5823.359430462646;5845.626277824707;5873.970630146908;1470.117929242446;1480.5410322799967;1482.8739557137549;1484.1836989655646;1484.3394689363129;1000.2648053680539;1001.1490233301636;1006.9949650251701;1013.8834034086175;1016.1718199667248;5139.357580302462;5140.511651393112;5143.4085080216255;5145.485451454824;5148.794048238028;6052.273727152769;6060.33336333003;6069.514438844882;6071.423214794676;6083.026715725463;5087.923681144785;5132.615053870974;5136.383633963948;5137.486251374833;5139.486051394831;3174.698403651649;3238.6883312258574;3268.839561955519;3279.32773781379;3286.819224942651;5604.887902242014;5812.854678632983;5836.9124463133085;5840.561957853093;5841.4450627190345;6281.214848143982;6298.874022519524;6300;6318.241810982619;6340.207474065742;5793.768249270066;5797.971010144923;5801.100829371454;5857.7656893724625;5877.706114694333;6080.574359794772;6100.450959413496;6120.1125836752535;6121.602095863755;6123.387661233841;5746.655200687972;5923.259592550931;5924.377940316204;5926.703664816656;5998.220231369894;5776.797812076557;5777.480026797609;5809.360970293349;5818.418158184148;5835.94164058354;4129.277376459047;4180.393842892703;4181.310083836133;4181.456410666594;4199.748015119103;5976;6098.115773212948;6107.358727333566;6113.57204995646;6116.17431646722;5847.152162936435;5853.268341457318;5868.178455016387;5900.498457631149;5904.380040095728;5832.825015249549;5835.066389377679;5864.560157988253;5875.529957603467;5887.7056147193325;5558.72206389687;5699.544036477155;5727.36998930109;5727.627704199213;5738.1679656450415;5894.086416605433;5899.321578018583;5912.172295878494;5916.26046744157;5917.408259174221;5764.250647415809;5772.191893135048;5773.942260577341;5774.307083150049;5789.2763404574425 15:49:51 INFO - PROCESS | 3796 | |5;yui.html;630.8643641617051;747.4655621230819;753.7022875963994;754.2306847016043;755.6184127015856;10680.305780124296;10861.891381086187;10980.780384392307;11036.668899932994;11082.168837337213;11170.329780213173;11216.270942388739;11228.775424491505;11277;11278.379689117095;607.8449995251204;614.6772944204283;745.9925400745977;763.5647680821934;780.7696729464822;760.9429292803035;761.5088268067093;769.5267410542532;769.6844293839526;771.0862627786064;804.1194891593696;809.7854068671807;810.0481933727875;810.1817164663703;810.2464707821753;797.4656979823532;798.3732769775698;802.9076656184556;804.0632662947688;804.3685706720255;589.0751520113423;590.2356448399333;590.9054551271776;591.8609126855185;592.4697395830707;10965.671029869116;10971.23201375904;11169.888301116966;11170.497327620276;11181.32912025281;10581.947090264499;11206.495707693091;11210.047145992601;11257.211995160342;11378.431078446127;8999.145081217273;9109.362344635878;9132.634694612207;9406.1064198901;9450.054994500564;3098.148009297439;3138.4193924123883;3162.2726772842143;3182.5703530023384;3186.6654001329757;37433.99999999973;37532.624673753184;37643.43534846979;37708.62291377106;37764;9280.95359523198;9546.474943878015;9633.421994680342;9658.855117173249;9806.901930980599;16256.593585160466;16472.505824825275;16523.421680241136;16662.00027998324;16695.74956375655;6225.501959843202;6264;6337.746490140435;6349.761796449648;6393.2328120625825;3349;3406.9488957665158;3484.8257587120543;3522.2427178156818;3540.7698499597445;2558.7441255874637;2564.1538292363475;2578.5487539680857;2581.9096331628302;2590.5078035173633;481.1675800864454;491.2116053733706;533.7331334332833;545.8253358925185;556.4241010554138;370.90727318170457;390.79287977372036;400.41739269363006;412.3505478870791;481.72782377956344;6307;6405.071264666597;6831.146106736658;6947.5831450113155;7117.46974400496;413.4274030467824;503.2099603622351;559.9244102046254;563.9266895303584;575.683374144219;3211.6788321168165;3327.800331980089;3396.524486571882;3703.9629603704157;3747.662710356081;47812.457816507376;47836.52163478321;48336.27495587569;48528.7573562137;48616.27075593869;39422.21155576872;39668;42415.7879210602;42730.78634606807;43284.567154328055;36709.632903671154;37366;37460.438093428624;37539.249215015545;37672.62327376746;7152.892706609509;7260.528065675714;7378.335949764547;7491.325780679765;7511.737089201852;30915.69084309128;31133.066008019796;31285.530717039717;31487.685123149393;31764;34194;34625.653743462244;38561.421578676905;38921.80539097286;38966.80516597399;9368.297377696565;9376.437413755197;9414;9615.615375385187;10132;10598.25812193139;10662.776862302007;10718.19613529004;10757.139428845518;11663.24188927717;9780.657676981271;9840.458774767456;9980.401175929468;10147.289689721649;10253.231007674305;10330.121939635215;10453.895461045293;10522.473876306001;10575.841362379724;10645.520951557044;9562.760930976503;9745.561449734638;9809.313348065567;9820.65627703027;9822.312438129262;8411.83176336482;8527.53098579584;8585.730295106463;8650.221480066824;8863.512506812187;8196.180381961756;8300.169983001651;8341.95829020851;8515.446495977742;8518.148185181431 15:49:51 INFO - PROCESS | 3796 | __end_tp_report 15:49:51 INFO - PROCESS | 3796 | __start_cc_report 15:49:51 INFO - PROCESS | 3796 | _x_x_mozilla_cycle_collect,322 15:49:51 INFO - PROCESS | 3796 | __end_cc_report 15:49:51 INFO - PROCESS | 3796 | __startTimestamp1451432991068__endTimestamp 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | ------- Summary: start ------- 15:49:51 INFO - PROCESS | 3796 | Number of tests: 6 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | [#0] dojo.html Cycles:165 Average:4686.94 Median:4826.37 stddev:475.60 (9.9%) stddev-sans-first:450.32 15:49:51 INFO - PROCESS | 3796 | Values: 2682.8 2731.1 2769.5 2776.0 2791.8 4564.2 4757.3 4778.1 4780.3 4809.2 4687.4 4693.5 4704.7 4827.0 4834.2 4312.3 4381.0 4441.5 4449.2 4485.5 4058.8 4430.3 4430.6 4449.2 4515.7 4215.1 4325.4 4425.1 4454.8 4469.2 4289.9 4294.1 4296.0 4296.3 4296.9 4354.1 4358.4 4398.6 4401.2 4437.8 4553.9 4563.9 4564.6 4615.4 4639.2 4890.2 4958.9 4959.6 5111.9 5118.3 5043.0 5070.4 5077.3 5087.4 5120.9 4715.2 4717.2 4720.4 4759.0 4761.4 5028.3 5151.9 5160.8 5198.5 5265.3 4928.1 4946.4 4951.9 4952.0 4961.4 5022.5 5043.1 5044.3 5047.7 5059.9 4881.4 4993.7 5014.3 5073.8 5124.3 4970.3 4983.3 4997.8 5002.4 5022.3 4131.8 4253.7 4267.7 4274.1 4320.9 3702.7 3735.6 3771.7 3794.9 3815.0 4367.9 4408.2 4409.4 4413.1 4465.4 4917.4 5053.3 5090.6 5108.0 5147.2 4401.9 4447.3 4451.7 4457.4 4483.1 4539.6 4578.5 4585.6 4610.3 4639.0 4641.6 4756.4 4779.6 4860.2 4915.7 5150.8 5166.8 5171.3 5176.8 5183.8 4879.0 4901.9 4902.2 4911.8 4950.7 4826.4 4929.0 5049.0 5083.5 5151.8 5004.6 5054.4 5067.5 5068.9 5108.0 4867.0 4868.7 4883.1 4900.4 4922.7 4747.0 4878.5 4908.9 4987.6 5037.6 4784.8 4798.1 4809.8 4813.3 4891.2 4853.1 5020.6 5025.4 5027.8 5063.8 4805.8 4887.0 4947.1 4950.8 5003.2 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | [#1] ext.html Cycles:180 Average:38481.96 Median:33676.49 stddev:61634.42 (183.0%) stddev-sans-first:61741.22 15:49:51 INFO - PROCESS | 3796 | Values: 465.3 503.4 507.2 512.4 539.9 32894.5 33573.7 33699.8 33711.3 33735.5 36793.8 37434.6 37439.4 37502.6 37527.4 7409.0 7721.7 7773.3 7787.8 7792.0 7581.2 7697.2 7732.7 7883.0 7909.0 7860.7 7864.8 7869.3 7927.9 7930.3 7363.8 7364.9 7379.2 7388.9 7414.2 7741.8 7891.3 7891.3 7894.8 7903.1 35185.6 35665.5 35773.5 35775.8 36085.3 2660.7 2722.9 2769.3 2800.1 3177.6 27864.4 28654.7 28708.4 28729.4 28959.8 3287.6 3323.7 3327.6 3351.2 3400.8 160350.0 160528.0 160533.0 160732.0 161163.0 53320.0 53676.7 53717.7 53940.2 53972.0 50276.2 51604.0 59608.4 60576.0 61099.0 11942.5 12127.8 12206.6 12246.8 12256.2 8044.6 8073.2 8073.8 8096.1 8128.3 18170.2 18417.8 18488.0 18507.4 18518.6 7004.2 7275.3 7361.2 7394.3 7485.5 822.3 888.9 899.6 929.7 978.6 23496.2 23694.6 25987.2 26692.0 26879.2 871.6 902.9 904.3 939.0 1000.9 12222.4 12463.6 12479.6 12519.3 12526.2 264781.0 268880.0 271958.0 272844.0 274110.0 45574.5 45593.5 45773.5 45840.0 45859.3 1103.9 1131.3 1132.2 1188.8 1201.8 23886.6 24003.0 24106.2 24133.0 24368.6 37593.1 38038.0 38110.2 38210.4 38292.0 258294.0 258421.0 259904.0 260494.0 260774.0 28300.9 29065.0 29189.3 29510.7 29555.3 33672.5 33999.3 34028.3 34669.8 34874.5 28774.4 29225.7 29320.4 29435.0 29904.1 30584.4 31132.0 31565.2 31846.0 32020.4 32808.0 33316.7 33485.3 33680.5 33737.2 27577.6 28715.0 30583.8 30833.8 31029.0 21750.5 21860.9 21902.0 22042.0 22107.0 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | [#2] jquery.html Cycles:180 Average:21026.06 Median:2431.72 stddev:54957.37 (2260.0%) stddev-sans-first:55089.58 15:49:51 INFO - PROCESS | 3796 | Values: 333.2 337.5 338.2 338.7 340.2 14634.9 15023.5 15569.9 15705.5 16166.9 9036.7 9263.0 9361.9 9918.5 9944.3 4420.9 4505.8 4532.2 4545.6 4554.2 4449.6 4520.6 4561.9 4563.0 4574.8 4554.6 4560.3 4725.4 4863.7 4896.5 4832.3 4840.4 4848.5 4868.6 4876.7 4561.4 4709.2 4733.2 4735.6 4740.3 10798.0 10811.9 10821.8 12766.2 17214.7 1589.3 1595.8 1607.0 1710.9 1755.1 8369.2 8447.9 8463.7 12051.2 12810.9 1667.4 1683.9 1709.8 1751.7 1764.2 53768.7 56748.7 57609.7 57625.0 58136.0 9347.6 9796.5 9803.0 9906.4 9918.8 12446.7 12533.8 12590.6 12605.9 12618.6 6237.0 6255.7 6394.1 6446.6 6582.1 5631.4 5645.8 5658.3 5718.5 5723.8 3887.5 3979.1 4126.5 4162.0 4217.6 1656.4 1707.4 1713.4 1754.7 1812.4 376.2 384.2 390.0 390.1 396.3 9162.2 9465.0 9535.0 9743.9 9794.4 377.4 377.5 383.7 385.5 392.1 5322.7 5337.6 5349.2 5377.4 5411.0 330618.8 332607.0 332686.0 335251.0 338089.0 60480.7 62543.4 62937.7 62984.7 63356.0 436.4 442.5 443.2 443.4 445.8 9410.2 9548.0 9552.8 9574.3 9695.4 32403.7 34035.8 34811.0 34999.3 35110.1 41789.8 43324.6 43729.6 44219.8 45465.5 7620.1 8743.6 8868.2 8868.4 8870.2 11485.4 16275.2 16339.3 16467.8 16734.7 12964.3 13347.0 13471.1 13624.2 13749.5 13107.1 13412.7 13647.8 13723.1 13928.5 13198.5 13515.8 13652.5 13666.9 13686.3 8283.1 8380.7 8455.1 8463.5 8488.0 8806.6 12797.4 13699.0 13738.7 13778.7 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | [#3] mootools.html Cycles:180 Average:4905.05 Median:6377.33 stddev:2573.49 (40.4%) stddev-sans-first:2567.00 15:49:51 INFO - PROCESS | 3796 | Values: 1370.0 1383.0 1474.9 1671.6 1685.4 7004.0 7030.2 7080.4 7090.1 7126.6 7015.3 7082.0 7109.8 7117.4 7190.0 2087.4 2120.8 2123.4 2124.1 2128.4 2105.3 2117.7 2126.3 2132.9 2137.9 1735.8 1786.5 2068.0 2069.1 2096.3 2063.3 2068.3 2069.7 2071.4 2075.8 2057.9 2070.3 2134.1 2136.0 2152.8 7018.8 7042.0 7050.1 7084.4 7122.3 4180.6 4258.6 4280.5 4292.6 4304.2 2772.4 2784.3 2904.9 2913.8 2941.1 863.4 887.4 908.3 919.4 922.5 9642.7 9701.4 9721.1 9729.7 9757.3 3713.9 3762.6 3837.6 3934.4 3961.3 7835.3 7869.6 7871.8 7876.3 7881.8 4212.2 4217.8 4227.6 4230.2 4231.4 3843.1 3868.1 3877.5 3879.1 3894.0 3149.1 3198.6 3219.5 3227.1 3230.9 960.6 961.1 963.1 966.2 968.9 753.7 772.4 813.7 861.5 934.8 6380.2 6507.9 6508.7 6510.2 6530.0 524.4 532.9 534.9 535.5 687.7 4869.4 4912.6 4966.6 4975.9 4980.5 8161.4 8278.8 8619.6 8644.3 8644.8 8432.9 8454.5 8509.2 8519.4 8533.8 6588.8 6731.7 6754.2 6755.5 6788.6 6374.5 6394.1 6412.3 6413.9 6433.3 7465.0 7548.1 7659.5 7716.1 7740.1 7628.6 7767.4 7795.1 7895.9 7938.0 6028.7 6064.2 6064.2 6066.4 6071.1 6639.8 6795.8 6796.2 6799.2 6799.4 6455.6 6479.9 6514.1 6537.2 6601.6 5371.1 5383.1 6066.5 6248.1 6314.4 6357.2 6404.4 6414.4 6432.3 6447.7 5760.5 5856.2 5868.4 5870.2 5879.1 5877.3 5934.7 5945.3 5946.0 5960.8 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | [#4] prototype.html Cycles:180 Average:4843.49 Median:5396.43 stddev:1440.52 (26.7%) stddev-sans-first:1403.77 15:49:51 INFO - PROCESS | 3796 | Values: 308.5 312.2 318.5 320.7 322.4 5410.7 5499.0 5568.4 5607.6 5618.6 5382.1 5521.1 5543.2 5550.4 5550.8 4296.5 4308.1 4317.8 4320.1 4322.2 4304.7 4309.4 4320.4 4324.3 4339.6 4056.6 4176.3 4284.5 4293.2 4295.6 4172.7 4179.2 4183.9 4184.3 4189.6 3674.4 3674.5 3674.9 3677.7 3680.9 5154.0 5246.7 5250.6 5257.2 5258.7 4878.7 4894.1 4897.3 4898.0 4898.7 5817.8 5820.8 5865.4 5869.7 5871.4 3833.7 3983.0 4006.3 4012.6 4016.9 6099.9 6116.7 6138.2 6156.4 6168.6 4151.4 4153.8 4160.5 4165.5 4169.3 4231.9 4233.4 4237.1 4238.4 4240.4 4666.8 4839.1 4847.1 4849.1 4865.7 5747.2 5800.6 5823.4 5845.6 5874.0 1470.1 1480.5 1482.9 1484.2 1484.3 1000.3 1001.1 1007.0 1013.9 1016.2 5139.4 5140.5 5143.4 5145.5 5148.8 6052.3 6060.3 6069.5 6071.4 6083.0 5087.9 5132.6 5136.4 5137.5 5139.5 3174.7 3238.7 3268.8 3279.3 3286.8 5604.9 5812.9 5836.9 5840.6 5841.4 6281.2 6298.9 6300.0 6318.2 6340.2 5793.8 5798.0 5801.1 5857.8 5877.7 6080.6 6100.5 6120.1 6121.6 6123.4 5746.7 5923.3 5924.4 5926.7 5998.2 5776.8 5777.5 5809.4 5818.4 5835.9 4129.3 4180.4 4181.3 4181.5 4199.7 5976.0 6098.1 6107.4 6113.6 6116.2 5847.2 5853.3 5868.2 5900.5 5904.4 5832.8 5835.1 5864.6 5875.5 5887.7 5558.7 5699.5 5727.4 5727.6 5738.2 5894.1 5899.3 5912.2 5916.3 5917.4 5764.3 5772.2 5773.9 5774.3 5789.3 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - PROCESS | 3796 | [#5] yui.html Cycles:180 Average:11649.81 Median:481.45 stddev:13075.49 (2715.9%) stddev-sans-first:13085.98 15:49:51 INFO - PROCESS | 3796 | Values: 630.9 747.5 753.7 754.2 755.6 10680.3 10861.9 10980.8 11036.7 11082.2 11170.3 11216.3 11228.8 11277.0 11278.4 607.8 614.7 746.0 763.6 780.8 760.9 761.5 769.5 769.7 771.1 804.1 809.8 810.0 810.2 810.2 797.5 798.4 802.9 804.1 804.4 589.1 590.2 590.9 591.9 592.5 10965.7 10971.2 11169.9 11170.5 11181.3 10581.9 11206.5 11210.0 11257.2 11378.4 8999.1 9109.4 9132.6 9406.1 9450.1 3098.1 3138.4 3162.3 3182.6 3186.7 37434.0 37532.6 37643.4 37708.6 37764.0 9281.0 9546.5 9633.4 9658.9 9806.9 16256.6 16472.5 16523.4 16662.0 16695.7 6225.5 6264.0 6337.7 6349.8 6393.2 3349.0 3406.9 3484.8 3522.2 3540.8 2558.7 2564.2 2578.5 2581.9 2590.5 481.2 491.2 533.7 545.8 556.4 370.9 390.8 400.4 412.4 481.7 6307.0 6405.1 6831.1 6947.6 7117.5 413.4 503.2 559.9 563.9 575.7 3211.7 3327.8 3396.5 3704.0 3747.7 47812.5 47836.5 48336.3 48528.8 48616.3 39422.2 39668.0 42415.8 42730.8 43284.6 36709.6 37366.0 37460.4 37539.2 37672.6 7152.9 7260.5 7378.3 7491.3 7511.7 30915.7 31133.1 31285.5 31487.7 31764.0 34194.0 34625.7 38561.4 38921.8 38966.8 9368.3 9376.4 9414.0 9615.6 10132.0 10598.3 10662.8 10718.2 10757.1 11663.2 9780.7 9840.5 9980.4 10147.3 10253.2 10330.1 10453.9 10522.5 10575.8 10645.5 9562.8 9745.6 9809.3 9820.7 9822.3 8411.8 8527.5 8585.7 8650.2 8863.5 8196.2 8300.2 8342.0 8515.4 8518.1 15:49:51 INFO - PROCESS | 3796 | -------- Summary: end -------- 15:49:51 INFO - PROCESS | 3796 | 15:49:51 INFO - TEST-INFO | 3796: exit 0 15:49:51 INFO - TEST-OK | dromaeo_css | took 1115794ms 15:49:51 INFO - TEST-START | kraken 15:49:51 INFO - operating with platform_type : linux_ 15:49:51 INFO - Initialising browser for kraken test... 15:49:51 INFO - TEST-INFO | started process 4036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwueHEj/profile http://localhost:41018/getInfo.html) 15:49:57 INFO - PROCESS | 4036 | __metrics Screen width/height:1600/1200 15:49:57 INFO - PROCESS | 4036 | colorDepth:24 15:49:57 INFO - PROCESS | 4036 | Browser inner width/height: 1024/697 15:49:57 INFO - PROCESS | 4036 | __metrics 15:49:57 INFO - PROCESS | 4036 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:49:58 INFO - TEST-INFO | 4036: exit 0 15:49:58 INFO - Browser initialized. 15:49:58 INFO - Running cycle 1/1 for kraken test... 15:49:58 INFO - TEST-INFO | started process 4156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwueHEj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:10 INFO - PROCESS | 4156 | RSS: Main: 149417984 15:50:10 INFO - PROCESS | 4156 | 15:50:13 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41018/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:13 INFO - PROCESS | 4156 | RSS: Main: 149700608 15:50:13 INFO - PROCESS | 4156 | 15:50:16 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41018/tests/kraken/driver.html?testName=audio-dft) 15:50:17 INFO - PROCESS | 4156 | RSS: Main: 150597632 15:50:17 INFO - PROCESS | 4156 | 15:50:19 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41018/tests/kraken/driver.html?testName=audio-fft) 15:50:20 INFO - PROCESS | 4156 | RSS: Main: 145113088 15:50:20 INFO - PROCESS | 4156 | 15:50:22 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41018/tests/kraken/driver.html?testName=audio-oscillator) 15:50:23 INFO - PROCESS | 4156 | RSS: Main: 146219008 15:50:23 INFO - PROCESS | 4156 | 15:50:25 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:26 INFO - PROCESS | 4156 | RSS: Main: 147365888 15:50:26 INFO - PROCESS | 4156 | 15:50:29 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41018/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:29 INFO - PROCESS | 4156 | RSS: Main: 147722240 15:50:29 INFO - PROCESS | 4156 | 15:50:33 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41018/tests/kraken/driver.html?testName=imaging-desaturate) 15:50:33 INFO - PROCESS | 4156 | RSS: Main: 148451328 15:50:33 INFO - PROCESS | 4156 | 15:50:36 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41018/tests/kraken/driver.html?testName=json-parse-financial) 15:50:37 INFO - PROCESS | 4156 | RSS: Main: 148897792 15:50:37 INFO - PROCESS | 4156 | 15:50:38 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:50:39 INFO - PROCESS | 4156 | RSS: Main: 147841024 15:50:39 INFO - PROCESS | 4156 | 15:50:41 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:50:42 INFO - PROCESS | 4156 | RSS: Main: 148824064 15:50:42 INFO - PROCESS | 4156 | 15:50:44 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:50:44 INFO - PROCESS | 4156 | RSS: Main: 149037056 15:50:44 INFO - PROCESS | 4156 | 15:50:47 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:50:47 INFO - PROCESS | 4156 | RSS: Main: 149725184 15:50:47 INFO - PROCESS | 4156 | 15:50:50 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:50:51 INFO - PROCESS | 4156 | RSS: Main: 149549056 15:50:51 INFO - PROCESS | 4156 | 15:50:52 INFO - PROCESS | 4156 | Cycle 1(1): loaded http://localhost:41018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41018/tests/kraken/driver.html?testName=ai-astar) 15:50:53 INFO - PROCESS | 4156 | RSS: Main: 148406272 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | __start_tp_report 15:50:53 INFO - PROCESS | 4156 | _x_x_mozilla_page_load 15:50:53 INFO - PROCESS | 4156 | _x_x_mozilla_page_load_details 15:50:53 INFO - PROCESS | 4156 | |i|pagename|runs| 15:50:53 INFO - PROCESS | 4156 | |0;ai-astar;113;108;114;114;117;126;115;113;113;117 15:50:53 INFO - PROCESS | 4156 | |1;audio-beat-detection;159;135;152;170;130;160;167;136;161;134 15:50:53 INFO - PROCESS | 4156 | |2;audio-dft;162;165;164;162;162;163;169;164;165;164 15:50:53 INFO - PROCESS | 4156 | |3;audio-fft;73;73;73;74;142;74;74;73;73;153 15:50:53 INFO - PROCESS | 4156 | |4;audio-oscillator;97;97;145;103;99;97;138;98;98;135 15:50:53 INFO - PROCESS | 4156 | |5;imaging-gaussian-blur;110;109;110;110;109;111;111;110;110;110 15:50:53 INFO - PROCESS | 4156 | |6;imaging-darkroom;148;148;148;147;149;149;148;148;148;148 15:50:53 INFO - PROCESS | 4156 | |7;imaging-desaturate;96;97;98;95;97;97;96;98;96;96 15:50:53 INFO - PROCESS | 4156 | |8;json-parse-financial;72;71;71;71;71;71;70;77;67;68 15:50:53 INFO - PROCESS | 4156 | |9;json-stringify-tinderbox;69;69;69;69;70;68;70;69;69;68 15:50:53 INFO - PROCESS | 4156 | |10;stanford-crypto-aes;83;84;84;84;87;85;86;85;85;94 15:50:53 INFO - PROCESS | 4156 | |11;stanford-crypto-ccm;140;119;121;122;121;131;127;124;129;137 15:50:53 INFO - PROCESS | 4156 | |12;stanford-crypto-pbkdf2;140;151;148;149;150;135;148;169;149;160 15:50:53 INFO - PROCESS | 4156 | |13;stanford-crypto-sha256-iterative;73;70;71;72;74;70;69;73;70;71 15:50:53 INFO - PROCESS | 4156 | __end_tp_report 15:50:53 INFO - PROCESS | 4156 | __start_cc_report 15:50:53 INFO - PROCESS | 4156 | _x_x_mozilla_cycle_collect,804 15:50:53 INFO - PROCESS | 4156 | __end_cc_report 15:50:53 INFO - PROCESS | 4156 | __startTimestamp1451433053244__endTimestamp 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | ------- Summary: start ------- 15:50:53 INFO - PROCESS | 4156 | Number of tests: 14 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.50 stddev:4.62 (4.0%) stddev-sans-first:4.84 15:50:53 INFO - PROCESS | 4156 | Values: 113.0 108.0 114.0 114.0 117.0 126.0 115.0 113.0 113.0 117.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:159.50 stddev:15.17 (9.5%) stddev-sans-first:15.76 15:50:53 INFO - PROCESS | 4156 | Values: 159.0 135.0 152.0 170.0 130.0 160.0 167.0 136.0 161.0 134.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.11 (1.3%) stddev-sans-first:2.11 15:50:53 INFO - PROCESS | 4156 | Values: 162.0 165.0 164.0 162.0 162.0 163.0 169.0 164.0 165.0 164.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#3] audio-fft Cycles:10 Average:88.20 Median:73.00 stddev:31.36 (43.0%) stddev-sans-first:32.78 15:50:53 INFO - PROCESS | 4156 | Values: 73.0 73.0 73.0 74.0 142.0 74.0 74.0 73.0 73.0 153.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:97.00 stddev:19.98 (20.6%) stddev-sans-first:20.57 15:50:53 INFO - PROCESS | 4156 | Values: 97.0 97.0 145.0 103.0 99.0 97.0 138.0 98.0 98.0 135.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 15:50:53 INFO - PROCESS | 4156 | Values: 110.0 109.0 110.0 110.0 109.0 111.0 111.0 110.0 110.0 110.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:50:53 INFO - PROCESS | 4156 | Values: 148.0 148.0 148.0 147.0 149.0 149.0 148.0 148.0 148.0 148.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:1.00 15:50:53 INFO - PROCESS | 4156 | Values: 96.0 97.0 98.0 95.0 97.0 97.0 96.0 98.0 96.0 96.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#8] json-parse-financial Cycles:10 Average:70.90 Median:71.00 stddev:2.64 (3.7%) stddev-sans-first:2.77 15:50:53 INFO - PROCESS | 4156 | Values: 72.0 71.0 71.0 71.0 71.0 71.0 70.0 77.0 67.0 68.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:50:53 INFO - PROCESS | 4156 | Values: 69.0 69.0 69.0 69.0 70.0 68.0 70.0 69.0 69.0 68.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:3.13 (3.7%) stddev-sans-first:3.16 15:50:53 INFO - PROCESS | 4156 | Values: 83.0 84.0 84.0 84.0 87.0 85.0 86.0 85.0 85.0 94.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:128.00 stddev:7.14 (5.6%) stddev-sans-first:5.85 15:50:53 INFO - PROCESS | 4156 | Values: 140.0 119.0 121.0 122.0 121.0 131.0 127.0 124.0 129.0 137.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:149.50 stddev:9.41 (6.3%) stddev-sans-first:9.27 15:50:53 INFO - PROCESS | 4156 | Values: 140.0 151.0 148.0 149.0 150.0 135.0 148.0 169.0 149.0 160.0 15:50:53 INFO - PROCESS | 4156 | 15:50:53 INFO - PROCESS | 4156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:1.64 (2.3%) stddev-sans-first:1.62 15:50:53 INFO - PROCESS | 4156 | Values: 73.0 70.0 71.0 72.0 74.0 70.0 69.0 73.0 70.0 71.0 15:50:53 INFO - PROCESS | 4156 | -------- Summary: end -------- 15:50:53 INFO - PROCESS | 4156 | 15:50:54 INFO - TEST-INFO | 4156: exit 0 15:50:54 INFO - TEST-OK | kraken | took 62374ms 15:50:54 INFO - TEST-START | v8_7 15:50:54 INFO - operating with platform_type : linux_ 15:50:54 INFO - Initialising browser for v8_7 test... 15:50:54 INFO - TEST-INFO | started process 4441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsdCNX0/profile http://localhost:41018/getInfo.html) 15:50:59 INFO - PROCESS | 4441 | __metrics Screen width/height:1600/1200 15:50:59 INFO - PROCESS | 4441 | colorDepth:24 15:50:59 INFO - PROCESS | 4441 | Browser inner width/height: 1024/697 15:50:59 INFO - PROCESS | 4441 | __metrics 15:50:59 INFO - PROCESS | 4441 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:51:00 INFO - TEST-INFO | 4441: exit 0 15:51:00 INFO - Browser initialized. 15:51:00 INFO - Running cycle 1/1 for v8_7 test... 15:51:00 INFO - TEST-INFO | started process 4559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsdCNX0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:12 INFO - PROCESS | 4559 | RSS: Main: 148836352 15:51:12 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | Cycle 1(1): loaded http://localhost:41018/tests/v8_7/run.html (next: http://localhost:41018/tests/v8_7/run.html) 15:51:34 INFO - PROCESS | 4559 | RSS: Main: 144977920 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | __start_tp_report 15:51:34 INFO - PROCESS | 4559 | _x_x_mozilla_page_load 15:51:34 INFO - PROCESS | 4559 | _x_x_mozilla_page_load_details 15:51:34 INFO - PROCESS | 4559 | |i|pagename|runs| 15:51:34 INFO - PROCESS | 4559 | |0;Richards;167.64459346186086 15:51:34 INFO - PROCESS | 4559 | |1;DeltaBlue;188.040616773223 15:51:34 INFO - PROCESS | 4559 | |2;Encrypt;278.00945232137894 15:51:34 INFO - PROCESS | 4559 | |3;Decrypt;5170.103092783505 15:51:34 INFO - PROCESS | 4559 | |4;RayTrace;1104.8565121412803 15:51:34 INFO - PROCESS | 4559 | |5;Earley;703.7297677691766 15:51:34 INFO - PROCESS | 4559 | |6;Boyer;12243.90243902439 15:51:34 INFO - PROCESS | 4559 | |7;RegExp;26256.410256410258 15:51:34 INFO - PROCESS | 4559 | |8;Splay;593.9537640782454 15:51:34 INFO - PROCESS | 4559 | |9;NavierStokes;4835.748792270531 15:51:34 INFO - PROCESS | 4559 | __end_tp_report 15:51:34 INFO - PROCESS | 4559 | __startTimestamp1451433094481__endTimestamp 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | ------- Summary: start ------- 15:51:34 INFO - PROCESS | 4559 | Number of tests: 10 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 167.6 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#1] DeltaBlue Cycles:1 Average:188.04 Median:188.04 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 188.0 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 278.0 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 5170.1 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#4] RayTrace Cycles:1 Average:1104.86 Median:1104.86 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 1104.9 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#5] Earley Cycles:1 Average:703.73 Median:703.73 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 703.7 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 12243.9 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 26256.4 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#8] Splay Cycles:1 Average:593.95 Median:593.95 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 594.0 15:51:34 INFO - PROCESS | 4559 | 15:51:34 INFO - PROCESS | 4559 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 15:51:34 INFO - PROCESS | 4559 | Values: 4835.7 15:51:34 INFO - PROCESS | 4559 | -------- Summary: end -------- 15:51:34 INFO - PROCESS | 4559 | 15:51:35 INFO - TEST-INFO | 4559: exit 0 15:51:35 INFO - TEST-OK | v8_7 | took 41219ms 15:51:35 INFO - SUITE-END | took 1219s 15:51:35 INFO - Completed test suite (00:20:19) 15:51:35 INFO - Working with test: dromaeo_css 15:51:35 INFO - Generating results file: dromaeo_css 15:51:35 INFO - Working with test: kraken 15:51:35 INFO - Generating results file: kraken 15:51:35 INFO - javascript benchmark 15:51:35 INFO - Working with test: v8_7 15:51:35 INFO - Generating results file: v8_7 15:51:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:51:36 INFO - process_Request line: dromaeo_css 6045.55 graph.html#tests=[[72,132,43]] 15:51:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:36 INFO - process_Request line: kraken 1556.90 graph.html#tests=[[232,132,43]] 15:51:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:36 INFO - process_Request line: v8_7 21294.59 graph.html#tests=[[230,132,43]] 15:51:36 INFO - RETURN: dromaeo_css: 6045.55 15:51:36 INFO - RETURN: kraken: 1556.90 15:51:36 INFO - RETURN: v8_7: 21294.59 15:51:36 INFO - javascript benchmark 15:51:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2682.771964383028, 2731.0987374166525, 2769.487644785715, 2776.0, 2791.7627001704855, 4564.246899261626, 4757.310190022445, 4778.139934811733, 4780.282957556368, 4809.158397280479, 4687.437507499105, 4693.5306469353045, 4704.670673052888, 4827.03459308138, 4834.178189707749, 4312.28847240205, 4380.956190438103, 4441.511433742286, 4449.221386257408, 4485.506594274627, 4058.783709173313, 4430.291153415455, 4430.556944305576, 4449.17690227309, 4515.6613254005915, 4215.051613386994, 4325.416068830699, 4425.137098265839, 4454.754988475633, 4469.173202957447, 4289.871303860889, 4294.076773493683, 4296.033392486696, 4296.291111966553, 4296.935545966813, 4354.085642015149, 4358.433403657505, 4398.648108151372, 4401.229784787682, 4437.822487100512, 4553.931691024637, 4563.9087218255445, 4564.589186973155, 4615.446146462446, 4639.234526303156, 4890.24201248807, 4958.87602809929, 4959.628027897886, 5111.872203194913, 5118.309028281172, 5042.974785126087, 5070.366204224472, 5077.2637967494875, 5087.440381558025, 5120.92318615221, 4715.151272770866, 4717.2452407614965, 4720.409948756405, 4759.024399998027, 4761.35721677576, 5028.270900719375, 5151.896962060738, 5160.767765450564, 5198.4801519847715, 5265.315508983807, 4928.112939670822, 4946.4064312282035, 4951.8514444566, 4951.9752401237765, 4961.355023846877, 5022.547970682656, 5043.067032598981, 5044.2937988681615, 5047.747612619354, 5059.949400506021, 4881.389826271716, 4993.675411098267, 5014.2979982802435, 5073.847784566469, 5124.256982737482, 4970.279309500174, 4983.27742477346, 4997.775100120431, 5002.399712034579, 5022.347094877716, 4131.752094874257, 4253.659707223414, 4267.679924005712, 4274.123804620045, 4320.913581728348, 3702.7037836972977, 3735.6451137141926, 3771.660550550409, 3794.8671796487542, 3814.9618503815163, 4367.890802729958, 4408.162449134654, 4409.4488188976375, 4413.124422120586, 4465.352523884018, 4917.360743103445, 5053.343065401475, 5090.643654944119, 5108.0, 5147.176451767699, 4401.867943961686, 4447.266201076851, 4451.710638808467, 4457.442819647544, 4483.058557702919, 4539.568740969668, 4578.519255478193, 4585.6102231310715, 4610.308453731967, 4639.048994956026, 4641.6286697064825, 4756.357891684716, 4779.593734532604, 4860.246661767432, 4915.68048076881, 5150.768215430389, 5166.767495462638, 5171.276021357088, 5176.792928282826, 5183.81856635016, 4878.975605121952, 4901.877453063702, 4902.2156454967035, 4911.8280860169725, 4950.727709975986, 4826.372571565674, 4928.975355123202, 5048.974755126201, 5083.542481176712, 5151.845444636667, 5004.624653150955, 5054.418741844588, 5067.467915868928, 5068.949310506848, 5107.978404319077, 4866.975665121652, 4868.659193856396, 4883.096627123993, 4900.387451568554, 4922.704637721748, 4747.0, 4878.512148785093, 4908.92636610444, 4987.625928055338, 5037.622178336713, 4784.760761961818, 4798.136335459651, 4809.759512024455, 4813.302071199727, 4891.217405215149, 4853.0779151961015, 5020.648554601143, 5025.39695236574, 5027.84916452507, 5063.8480845574695, 4805.7597120144555, 4886.975565122151, 4947.060058588857, 4950.752462376939, 5003.199488082035], "unit": "score", "name": "dojo.html", "value": 4658.320873638755}, {"lowerIsBetter": false, "replicates": [465.3345715626655, 503.3707865168538, 507.2138185811993, 512.4184051102, 539.8731298144933, 32894.506582401256, 33573.66426335736, 33699.83150084252, 33711.32577348452, 33735.493967590504, 36793.81603091981, 37434.62565374345, 37439.43840842389, 37502.624973750324, 37527.437088443694, 7408.96295518523, 7721.72973945912, 7773.261540153705, 7787.805304867367, 7792.0, 7581.2039735827775, 7697.191794861543, 7732.729354472594, 7883.0, 7909.0, 7860.724874629389, 7864.803379915491, 7869.331106855924, 7927.920720792776, 7930.286274235317, 7363.77908662741, 7364.926350736504, 7379.1513975892385, 7388.852222955537, 7414.184439711627, 7741.7677469676, 7891.2897839194175, 7891.289783919475, 7894.763157105296, 7903.0911445183965, 35185.64814351875, 35665.46501802475, 35773.46339804905, 35775.82112089449, 36085.278294434225, 2660.6674165729282, 2722.891084356623, 2769.2661444717164, 2800.1179628416985, 3177.5710279112254, 27864.442711145664, 28654.71345286562, 28708.425831483462, 28729.425411491655, 28959.84160633572, 3287.605487341534, 3323.667633236681, 3327.617324007746, 3351.1957130288556, 3400.7619466637343, 160350.0, 160528.0, 160533.0, 160732.0, 161163.0, 53320.0, 53676.73161634167, 53717.73141134269, 53940.19089713658, 53972.0, 50276.24585631218, 51604.0, 59608.40391596115, 60576.0, 61099.0, 11942.462589183508, 12127.818082728767, 12206.633800985985, 12246.755064898653, 12256.203346782431, 8044.557549334842, 8073.152319006537, 8073.83852322962, 8096.149904259968, 8128.268455839003, 18170.18234179465, 18417.81582184188, 18488.0, 18507.35224267171, 18518.629627407376, 7004.194517630538, 7275.308845659654, 7361.153467351216, 7394.334509894028, 7485.513441626277, 822.333909533268, 888.8711136885115, 899.6266549382065, 929.7350255177242, 978.6379039755336, 23496.177633782736, 23694.644580331307, 25987.22038338853, 26692.0, 26879.193624191306, 871.6034204437093, 902.9051949545203, 904.3398319226869, 939.0421769794771, 1000.8949060348705, 12222.388880556115, 12463.563775267821, 12479.56321528742, 12519.311437871005, 12526.185797923106, 264781.0, 268880.0, 271958.0, 272844.0, 274110.0, 45574.54425455703, 45593.544064559595, 45773.54226457759, 45840.0, 45859.3121103177, 1103.9448027598587, 1131.3042478875598, 1132.1565433751907, 1188.7979043562616, 1201.7836789377996, 23886.64170037416, 24003.0, 24106.156284529956, 24133.0, 24368.63447048331, 37593.060173495884, 38038.0, 38110.237795244495, 38210.426843597925, 38292.0, 258294.0, 258421.0, 259904.0, 260494.0, 260774.0, 28300.85849570739, 29065.0, 29189.270268243465, 29510.704892950795, 29555.261118472212, 33672.49491257584, 33999.32001359909, 34028.3194336107, 34669.826650867595, 34874.47688284729, 28774.42451151007, 29225.7077429223, 29320.413591727618, 29435.0, 29904.102876913727, 30584.388312234074, 31132.0, 31565.21086972752, 31846.0, 32020.35959280755, 32808.0, 33316.66683333136, 33485.33029339448, 33680.49479257764, 33737.15657108592, 27577.58633620457, 28714.98995070325, 30583.847080765343, 30833.845830770704, 31029.0, 21750.49732856407, 21860.89069554642, 21902.0, 22042.0, 22107.0], "unit": "score", "name": "ext.html", "value": 15937.703232167372}, {"lowerIsBetter": false, "replicates": [333.1537893749875, 337.5004992610936, 338.18328736102313, 338.7273245037745, 340.20052875741993, 14634.853651463482, 15023.549293521199, 15569.922150389231, 15705.450309239179, 16166.919165404186, 9036.68371606994, 9262.953685231581, 9361.906380936205, 9918.504074796267, 9944.254180936441, 4420.9115817683705, 4505.819767209307, 4532.184206842783, 4545.6136228420455, 4554.157480866033, 4449.621782148522, 4520.615747661436, 4561.885952851172, 4562.9771851140695, 4574.794134263966, 4554.590086892179, 4560.315952607119, 4725.432948046222, 4863.732494712789, 4896.46138924718, 4832.323474713543, 4840.370751802261, 4848.5151484851585, 4868.610511159134, 4876.731779752112, 4561.384213131251, 4709.2229782085915, 4733.171694953369, 4735.621150307967, 4740.265258884879, 10798.0, 10811.891881081167, 10821.83767243492, 12766.17019893704, 17214.741778873326, 1589.3324803582523, 1595.7845690831705, 1606.9598260043476, 1710.9230084646222, 1755.0522717732408, 8369.204925532065, 8447.915520844774, 8463.74608761738, 12051.216670916363, 12810.871891281155, 1667.4247384652276, 1683.8989660620402, 1709.820468850765, 1751.7372394140853, 1764.2325588369101, 53768.73115634436, 56748.71625641887, 57609.711951439975, 57625.0, 58136.0, 9347.626094956262, 9796.510174491246, 9803.0, 9906.356086854332, 9918.80162396748, 12446.688832779253, 12533.811992820116, 12590.622281331574, 12605.87394126047, 12618.558350457874, 6237.033259844731, 6255.655938923312, 6394.072859435356, 6446.613203207822, 6582.111414959015, 5631.4087020863035, 5645.830625081254, 5658.264425624642, 5718.485336319751, 5723.828285151452, 3887.5140607424073, 3979.144483935968, 4126.504819421629, 4161.97919010403, 4217.578242175758, 1656.403694669918, 1707.4450803488917, 1713.400309891528, 1754.6841568517789, 1812.3837895115723, 376.22309929994475, 384.2181161336666, 389.9863504777319, 390.1475276520811, 396.29459561979724, 9162.221211197122, 9465.0, 9534.95232523833, 9743.853842192373, 9794.412335259907, 377.3660250778718, 377.5069599733104, 383.71029872446127, 385.5450568329342, 392.1079544037338, 5322.654027488278, 5337.599680024014, 5349.22436246742, 5377.3816011159215, 5411.026015317202, 330618.77524899214, 332607.0, 332686.0, 335251.0, 338089.0, 60480.69759651174, 62543.374566254664, 62937.68531157407, 62984.68507657432, 63356.0, 436.3629101511765, 442.52428639212974, 443.19781196034637, 443.38812438834844, 445.7592899834053, 9410.200132988499, 9547.952260238655, 9552.761180970254, 9574.281928855504, 9695.418274903528, 32403.67596324101, 34035.82982085074, 34811.0, 34999.30001399907, 35110.12224694403, 41789.79105104455, 43324.56675433205, 43729.56270437255, 44219.77890110529, 45465.54534454613, 7620.123685775985, 8743.606537705946, 8868.201861832466, 8868.423552469327, 8870.15733505316, 11485.368304743319, 16275.186240688156, 16339.346426142822, 16467.835321647108, 16734.748978765572, 12964.286964217059, 13347.0, 13471.12437691547, 13624.18254904709, 13749.450021999008, 13107.148035378052, 13412.731745365234, 13647.79528307096, 13723.1079979801, 13928.51250206238, 13198.472061117447, 13515.797263040866, 13652.453901843815, 13666.86333136656, 13686.315684215948, 8283.08886022525, 8380.664773408995, 8455.069942306465, 8463.53450560225, 8487.957560212159, 8806.64773409082, 12797.42411591462, 13699.0, 13738.65653358634, 13778.65553361174], "unit": "score", "name": "jquery.html", "value": 6981.027271746009}, {"lowerIsBetter": false, "replicates": [1369.972600547989, 1382.9999999999998, 1474.9041312314698, 1671.615528428462, 1685.4269548353557, 7003.964980175098, 7030.156381234259, 7080.398166155876, 7090.078289822322, 7126.643667816601, 7015.263397343282, 7082.043924070249, 7109.822254443641, 7117.359437650611, 7190.029346038284, 2087.4468265909545, 2120.830333573318, 2123.4160605833363, 2124.0866427436194, 2128.3934078787547, 2105.315772373977, 2117.6717608770587, 2126.2876936226307, 2132.9040193191267, 2137.8824164670937, 1735.7656716343322, 1786.4997800615783, 2068.0, 2069.0896005757418, 2096.2558291806417, 2063.288165582864, 2068.2864411777987, 2069.689546568027, 2071.4200023993308, 2075.7716651168357, 2057.9176832926814, 2070.2960993262363, 2134.1463414634113, 2136.0, 2152.752433470155, 7018.824529386755, 7042.0493233413345, 7050.083489146378, 7084.362407383309, 7122.323379278961, 4180.644645205161, 4258.61672449481, 4280.4863416390235, 4292.613664770186, 4304.182205380967, 2772.4039331543613, 2784.303924018995, 2904.8838046478118, 2913.766898648103, 2941.1176647006027, 863.3956230638578, 887.4231749362966, 908.2733812949614, 919.3610440743686, 922.5064590444081, 9642.662506812228, 9701.417914925127, 9721.076497732774, 9729.659461918869, 9757.316987810857, 3713.925721485555, 3762.567304759933, 3837.57786643469, 3934.409838524244, 3961.346377847623, 7835.294823465915, 7869.645865936047, 7871.803204919923, 7876.330511906437, 7881.842363152819, 4212.220739163204, 4217.810198541073, 4227.577242275809, 4230.2174097792, 4231.386448964944, 3843.0776613612534, 3868.1103346230525, 3877.495925529663, 3879.1078052047624, 3894.045958740127, 3149.0710240479116, 3198.552202691625, 3219.5492631031675, 3227.128675257667, 3230.8869189578254, 960.5629438605557, 961.0821665309612, 963.0610155098863, 966.2221911361281, 968.8740463739668, 753.7437271327775, 772.3743767548303, 813.6623301329881, 861.5046348349724, 934.8083642853198, 6380.202474690664, 6507.869842603216, 6508.674566271668, 6510.21877374718, 6529.967350163219, 524.4336116993637, 532.8880935003615, 534.9117395629755, 535.5447869311055, 687.6871023684212, 4869.415670119608, 4912.557869791736, 4966.553010229024, 4975.875603109879, 4980.5019498049905, 8161.387895907831, 8278.751637450887, 8619.569021548898, 8644.265237454887, 8644.783880402914, 8432.915670843337, 8454.492730436194, 8509.234168924826, 8519.446235994641, 8533.786655333543, 6588.835279117964, 6731.730730770714, 6754.223264324567, 6755.527113102134, 6788.5926844388505, 6374.458171055512, 6394.072859435263, 6412.326705695835, 6413.903791443226, 6433.260175079926, 7464.962675186806, 7548.056492938383, 7659.540427574363, 7716.074071111502, 7740.148583655906, 7628.580428076287, 7767.417443691633, 7795.103563090091, 7895.921040789519, 7938.0, 6028.728707208098, 6064.151018857276, 6064.211652485325, 6066.3630318815885, 6071.119687645355, 6639.800805975829, 6795.830104247433, 6796.184457865088, 6799.150106236721, 6799.422049125682, 6455.644939528371, 6479.935200647933, 6514.120593719787, 6537.1501704778075, 6601.603903765789, 5371.140617501181, 5383.08487557124, 6066.514678825595, 6248.062790581449, 6314.400131987454, 6357.205349331333, 6404.423601875854, 6414.358564143548, 6432.292447830641, 6447.70985305653, 5760.539156867357, 5856.209411729362, 5868.38381969887, 5870.207521984648, 5879.05935050407, 5877.324107727495, 5934.732937017759, 5945.346011938596, 5946.048632218824, 5960.76156953717], "unit": "score", "name": "mootools.html", "value": 3958.3453766167204}, {"lowerIsBetter": false, "replicates": [308.4802108447266, 312.1680720878858, 318.51585589903345, 320.71393711218036, 322.36654972978107, 5410.729463526827, 5499.0, 5568.443155684429, 5607.6074674772735, 5618.5786066045, 5382.138857782756, 5521.116621340586, 5543.168524721294, 5550.389457159719, 5550.750216240269, 4296.48442186938, 4308.052228509723, 4317.827286908519, 4320.135972805436, 4322.157179350036, 4304.720193187449, 4309.396684464162, 4320.438343015419, 4324.329728892011, 4339.609435150835, 4056.634902858742, 4176.269152898246, 4284.507281662618, 4293.248681480728, 4295.613394794468, 4172.749635021908, 4179.205950869356, 4183.91632167355, 4184.267753143203, 4189.560096189902, 3674.430463278196, 3674.503941967827, 3674.8530058797883, 3677.7241706871823, 3680.9263814723554, 5154.0, 5246.737663116829, 5250.6324557281005, 5257.185136303879, 5258.658187217857, 4878.707277563322, 4894.119058569456, 4897.314375987365, 4898.044881248158, 4898.657094003421, 5817.825465236049, 5820.82537523875, 5865.442782935615, 5869.735861886225, 5871.442212989759, 3833.674137698299, 3982.980085099585, 4006.2788698034633, 4012.578679238667, 4016.9196616067516, 6099.878002439971, 6116.724747386334, 6138.202033735586, 6156.415140561639, 6168.568200226031, 4151.4395556599475, 4153.813078411479, 4160.54234034256, 4165.500139983161, 4169.291220492523, 4231.851885184004, 4233.449651545279, 4237.110206856533, 4238.385434112098, 4240.406343111967, 4666.789994450258, 4839.056384005085, 4847.079054979543, 4849.102915960559, 4865.7323847188745, 5747.166660834156, 5800.622959507618, 5823.359430462646, 5845.626277824707, 5873.970630146908, 1470.117929242446, 1480.5410322799967, 1482.8739557137549, 1484.1836989655646, 1484.3394689363129, 1000.2648053680539, 1001.1490233301636, 1006.9949650251701, 1013.8834034086175, 1016.1718199667248, 5139.357580302462, 5140.511651393112, 5143.4085080216255, 5145.485451454824, 5148.794048238028, 6052.273727152769, 6060.33336333003, 6069.514438844882, 6071.423214794676, 6083.026715725463, 5087.923681144785, 5132.615053870974, 5136.383633963948, 5137.486251374833, 5139.486051394831, 3174.698403651649, 3238.6883312258574, 3268.839561955519, 3279.32773781379, 3286.819224942651, 5604.887902242014, 5812.854678632983, 5836.9124463133085, 5840.561957853093, 5841.4450627190345, 6281.214848143982, 6298.874022519524, 6300.0, 6318.241810982619, 6340.207474065742, 5793.768249270066, 5797.971010144923, 5801.100829371454, 5857.7656893724625, 5877.706114694333, 6080.574359794772, 6100.450959413496, 6120.1125836752535, 6121.602095863755, 6123.387661233841, 5746.655200687972, 5923.259592550931, 5924.377940316204, 5926.703664816656, 5998.220231369894, 5776.797812076557, 5777.480026797609, 5809.360970293349, 5818.418158184148, 5835.94164058354, 4129.277376459047, 4180.393842892703, 4181.310083836133, 4181.456410666594, 4199.748015119103, 5976.0, 6098.115773212948, 6107.358727333566, 6113.57204995646, 6116.17431646722, 5847.152162936435, 5853.268341457318, 5868.178455016387, 5900.498457631149, 5904.380040095728, 5832.825015249549, 5835.066389377679, 5864.560157988253, 5875.529957603467, 5887.7056147193325, 5558.72206389687, 5699.544036477155, 5727.36998930109, 5727.627704199213, 5738.1679656450415, 5894.086416605433, 5899.321578018583, 5912.172295878494, 5916.26046744157, 5917.408259174221, 5764.250647415809, 5772.191893135048, 5773.942260577341, 5774.307083150049, 5789.2763404574425], "unit": "score", "name": "prototype.html", "value": 4379.737148961057}, {"lowerIsBetter": false, "replicates": [630.8643641617051, 747.4655621230819, 753.7022875963994, 754.2306847016043, 755.6184127015856, 10680.305780124296, 10861.891381086187, 10980.780384392307, 11036.668899932994, 11082.168837337213, 11170.329780213173, 11216.270942388739, 11228.775424491505, 11277.0, 11278.379689117095, 607.8449995251204, 614.6772944204283, 745.9925400745977, 763.5647680821934, 780.7696729464822, 760.9429292803035, 761.5088268067093, 769.5267410542532, 769.6844293839526, 771.0862627786064, 804.1194891593696, 809.7854068671807, 810.0481933727875, 810.1817164663703, 810.2464707821753, 797.4656979823532, 798.3732769775698, 802.9076656184556, 804.0632662947688, 804.3685706720255, 589.0751520113423, 590.2356448399333, 590.9054551271776, 591.8609126855185, 592.4697395830707, 10965.671029869116, 10971.23201375904, 11169.888301116966, 11170.497327620276, 11181.32912025281, 10581.947090264499, 11206.495707693091, 11210.047145992601, 11257.211995160342, 11378.431078446127, 8999.145081217273, 9109.362344635878, 9132.634694612207, 9406.1064198901, 9450.054994500564, 3098.148009297439, 3138.4193924123883, 3162.2726772842143, 3182.5703530023384, 3186.6654001329757, 37433.99999999973, 37532.624673753184, 37643.43534846979, 37708.62291377106, 37764.0, 9280.95359523198, 9546.474943878015, 9633.421994680342, 9658.855117173249, 9806.901930980599, 16256.593585160466, 16472.505824825275, 16523.421680241136, 16662.00027998324, 16695.74956375655, 6225.501959843202, 6264.0, 6337.746490140435, 6349.761796449648, 6393.2328120625825, 3349.0, 3406.9488957665158, 3484.8257587120543, 3522.2427178156818, 3540.7698499597445, 2558.7441255874637, 2564.1538292363475, 2578.5487539680857, 2581.9096331628302, 2590.5078035173633, 481.1675800864454, 491.2116053733706, 533.7331334332833, 545.8253358925185, 556.4241010554138, 370.90727318170457, 390.79287977372036, 400.41739269363006, 412.3505478870791, 481.72782377956344, 6307.0, 6405.071264666597, 6831.146106736658, 6947.5831450113155, 7117.46974400496, 413.4274030467824, 503.2099603622351, 559.9244102046254, 563.9266895303584, 575.683374144219, 3211.6788321168165, 3327.800331980089, 3396.524486571882, 3703.9629603704157, 3747.662710356081, 47812.457816507376, 47836.52163478321, 48336.27495587569, 48528.7573562137, 48616.27075593869, 39422.21155576872, 39668.0, 42415.7879210602, 42730.78634606807, 43284.567154328055, 36709.632903671154, 37366.0, 37460.438093428624, 37539.249215015545, 37672.62327376746, 7152.892706609509, 7260.528065675714, 7378.335949764547, 7491.325780679765, 7511.737089201852, 30915.69084309128, 31133.066008019796, 31285.530717039717, 31487.685123149393, 31764.0, 34194.0, 34625.653743462244, 38561.421578676905, 38921.80539097286, 38966.80516597399, 9368.297377696565, 9376.437413755197, 9414.0, 9615.615375385187, 10132.0, 10598.25812193139, 10662.776862302007, 10718.19613529004, 10757.139428845518, 11663.24188927717, 9780.657676981271, 9840.458774767456, 9980.401175929468, 10147.289689721649, 10253.231007674305, 10330.121939635215, 10453.895461045293, 10522.473876306001, 10575.841362379724, 10645.520951557044, 9562.760930976503, 9745.561449734638, 9809.313348065567, 9820.65627703027, 9822.312438129262, 8411.83176336482, 8527.53098579584, 8585.730295106463, 8650.221480066824, 8863.512506812187, 8196.180381961756, 8300.169983001651, 8341.95829020851, 8515.446495977742, 8518.148185181431], "unit": "score", "name": "yui.html", "value": 5432.99065651631}], "name": "dromaeo_css", "value": 6045.551681426978}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 114.0, 114.0, 117.0, 126.0, 115.0, 113.0, 113.0, 117.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [159.0, 135.0, 152.0, 170.0, 130.0, 160.0, 167.0, 136.0, 161.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 164.0, 162.0, 162.0, 163.0, 169.0, 164.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 74.0, 142.0, 74.0, 74.0, 73.0, 73.0, 153.0], "unit": "score", "name": "audio-fft", "value": 88.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 145.0, 103.0, 99.0, 97.0, 138.0, 98.0, 98.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 95.0, 97.0, 97.0, 96.0, 98.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 71.0, 71.0, 71.0, 70.0, 77.0, 67.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 68.0, 70.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 87.0, 85.0, 86.0, 85.0, 85.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [140.0, 119.0, 121.0, 122.0, 121.0, 131.0, 127.0, 124.0, 129.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 148.0, 149.0, 150.0, 135.0, 148.0, 169.0, 149.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 71.0, 72.0, 74.0, 70.0, 69.0, 73.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1556.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [188.040616773223], "unit": "score", "name": "DeltaBlue", "value": 351.6155239999999}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1104.8565121412803], "unit": "score", "name": "RayTrace", "value": 669.760273726274}, {"lowerIsBetter": false, "replicates": [703.7297677691766], "unit": "score", "name": "Earley", "value": 947.0439230000003}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [593.9537640782454], "unit": "score", "name": "Splay", "value": 137.20091516966073}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21294.592750482403}]} 15:51:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21294.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1556.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6045.55"}}} 15:51:36 INFO - Return code: 0 15:51:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:51:36 INFO - # TBPL SUCCESS # 15:51:36 INFO - Running post-action listener: _resource_record_post_action 15:51:36 INFO - Running post-run listener: _resource_record_post_run 15:51:37 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 16384; Write bytes: 557916160; Read time: 388; Write time: 943584 15:51:37 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 4096; Write bytes: 240689152; Read time: 188; Write time: 582740 15:51:37 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 12288; Write bytes: 313135104; Read time: 200; Write time: 359944 15:51:37 INFO - Running post-run listener: _upload_blobber_files 15:51:37 INFO - Blob upload gear active. 15:51:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:37 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 15:51:37 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'] 15:51:37 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 15:51:37 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:51:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:38 INFO - (blobuploader) - INFO - Done attempting. 15:51:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:51:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:51:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:39 INFO - (blobuploader) - INFO - Done attempting. 15:51:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:39 INFO - Return code: 0 15:51:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d96f9be1554495bdc3434a148b07d69f417f48bc146e8610eb16e2162c09f8a7f64bc1d9355728d10e75c23bcd9b0d75e237fa18d314fd9f1eb479a122e19a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b07e18a1caf38edeb98cc61e3145a05283265437ac45fd6e8e3c09d3eb47a7b402e0aac6d76c22d4220f58e9f889368066fa1b46407ff8ec10ed8f1d08f7e069"} 15:51:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:39 INFO - Contents: 15:51:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d96f9be1554495bdc3434a148b07d69f417f48bc146e8610eb16e2162c09f8a7f64bc1d9355728d10e75c23bcd9b0d75e237fa18d314fd9f1eb479a122e19a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b07e18a1caf38edeb98cc61e3145a05283265437ac45fd6e8e3c09d3eb47a7b402e0aac6d76c22d4220f58e9f889368066fa1b46407ff8ec10ed8f1d08f7e069"} 15:51:39 INFO - Copying logs to upload dir... 15:51:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.884264 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-29 15:51:39.332106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:39.335585) ========= 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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 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/6d96f9be1554495bdc3434a148b07d69f417f48bc146e8610eb16e2162c09f8a7f64bc1d9355728d10e75c23bcd9b0d75e237fa18d314fd9f1eb479a122e19a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b07e18a1caf38edeb98cc61e3145a05283265437ac45fd6e8e3c09d3eb47a7b402e0aac6d76c22d4220f58e9f889368066fa1b46407ff8ec10ed8f1d08f7e069"} build_url:https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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/6d96f9be1554495bdc3434a148b07d69f417f48bc146e8610eb16e2162c09f8a7f64bc1d9355728d10e75c23bcd9b0d75e237fa18d314fd9f1eb479a122e19a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b07e18a1caf38edeb98cc61e3145a05283265437ac45fd6e8e3c09d3eb47a7b402e0aac6d76c22d4220f58e9f889368066fa1b46407ff8ec10ed8f1d08f7e069"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:39.360889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:39.361298) ========= 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=a194aa7faa1be204aaca7d660000020b-1451424138.515188-80342870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:39.443637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 15:51:39.443956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 15:51:39.444463) ========= ========= Total master_lag: 0.27 =========