builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1451499327.69 results: success (0) buildid: 20151230093737 builduid: 33d0a35870f84d86a9e347271523266b revision: 63227efdffeffc2b8dc6f0fc999c13809b753a43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.693626) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.694263) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.698001) ========= 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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006380 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.750725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.751112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.867417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.867708) ========= 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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.917779) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.918078) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.921542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:27.921882) ========= 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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 10:15:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-30 10:15:29 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179531 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.119917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.120499) ========= 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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019435 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.181150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.181615) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63227efdffeffc2b8dc6f0fc999c13809b753a43 --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 63227efdffeffc2b8dc6f0fc999c13809b753a43 --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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 10:15:29,760 truncating revision to first 12 chars 2015-12-30 10:15:29,761 Setting DEBUG logging. 2015-12-30 10:15:29,761 attempt 1/10 2015-12-30 10:15:29,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63227efdffef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 10:15:29,994 unpacking tar archive at: fx-team-63227efdffef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.714749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.715097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.729258) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.729620) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 10:15:28.730034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 10:15:28.730325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:30 INFO - MultiFileLogger online at 20151230 10:15:30 in /builds/slave/test 10:15:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 10:15:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:30 INFO - {'append_to_log': False, 10:15:30 INFO - 'base_work_dir': '/builds/slave/test', 10:15:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:15:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:30 INFO - 'branch': 'Fx-Team-Non-PGO', 10:15:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:30 INFO - 'config_files': ('talos/linux_config.py',), 10:15:30 INFO - 'default_actions': ('clobber', 10:15:30 INFO - 'read-buildbot-config', 10:15:30 INFO - 'download-and-extract', 10:15:30 INFO - 'populate-webroot', 10:15:30 INFO - 'create-virtualenv', 10:15:30 INFO - 'install', 10:15:30 INFO - 'run-tests'), 10:15:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:30 INFO - 'download_minidump_stackwalk': True, 10:15:30 INFO - 'download_symbols': 'ondemand', 10:15:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:30 INFO - 'installer_path': 'installer.exe', 10:15:30 INFO - 'log_level': 'info', 10:15:30 INFO - 'log_name': 'talos', 10:15:30 INFO - 'log_to_console': True, 10:15:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:30 INFO - 'opt_config_files': (), 10:15:30 INFO - 'pip_index': False, 10:15:30 INFO - 'sps_profile': False, 10:15:30 INFO - 'sps_profile_interval': 0, 10:15:30 INFO - 'suite': 'dromaeojs', 10:15:30 INFO - 'system_bits': '32', 10:15:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:30 INFO - 'title': 'talos-linux64-ix-053', 10:15:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:30 INFO - 'use_talos_json': True, 10:15:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:30 INFO - 'work_dir': 'build'} 10:15:30 INFO - ##### 10:15:30 INFO - ##### Running clobber step. 10:15:30 INFO - ##### 10:15:30 INFO - Running pre-action listener: _resource_record_pre_action 10:15:30 INFO - Running main action method: clobber 10:15:30 INFO - rmtree: /builds/slave/test/build 10:15:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:30 INFO - Running post-action listener: _resource_record_post_action 10:15:30 INFO - ##### 10:15:30 INFO - ##### Running read-buildbot-config step. 10:15:30 INFO - ##### 10:15:30 INFO - Running pre-action listener: _resource_record_pre_action 10:15:30 INFO - Running main action method: read_buildbot_config 10:15:30 INFO - Using buildbot properties: 10:15:30 INFO - { 10:15:30 INFO - "project": "", 10:15:30 INFO - "product": "firefox", 10:15:30 INFO - "script_repo_revision": "production", 10:15:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:15:30 INFO - "repository": "", 10:15:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:15:30 INFO - "buildid": "20151230093737", 10:15:30 INFO - "pgo_build": "False", 10:15:30 INFO - "basedir": "/builds/slave/test", 10:15:30 INFO - "buildnumber": 1059, 10:15:30 INFO - "slavename": "talos-linux64-ix-053", 10:15:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:15:30 INFO - "platform": "ubuntu64_hw", 10:15:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:15:30 INFO - "branch": "fx-team", 10:15:30 INFO - "repo_path": "integration/fx-team", 10:15:30 INFO - "revision": "63227efdffeffc2b8dc6f0fc999c13809b753a43", 10:15:30 INFO - "stage_platform": "linux64", 10:15:30 INFO - "builduid": "33d0a35870f84d86a9e347271523266b", 10:15:30 INFO - "slavebuilddir": "test" 10:15:30 INFO - } 10:15:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:15:30 INFO - Running post-action listener: _resource_record_post_action 10:15:30 INFO - ##### 10:15:30 INFO - ##### Running download-and-extract step. 10:15:30 INFO - ##### 10:15:30 INFO - Running pre-action listener: _resource_record_pre_action 10:15:30 INFO - Running main action method: download_and_extract 10:15:30 INFO - mkdir: /builds/slave/test/build/tests 10:15: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')]} 10:15:30 INFO - https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/test_packages.json 10:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/test_packages.json 10:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:15:38 INFO - Downloaded 1302 bytes. 10:15:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:15:38 INFO - Using the following test package requirements: 10:15:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:38 INFO - u'jsshell-linux-x86_64.zip'], 10:15:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15: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')]} 10:15:38 INFO - https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:15:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:15:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:40 INFO - Downloaded 21953250 bytes. 10:15:40 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 10:15:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:15:40 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 10:15:41 INFO - Return code: 0 10:15:41 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 10:15: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')]} 10:15:41 INFO - https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:43 INFO - Downloaded 21953250 bytes. 10:15:43 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 10:15:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:15:43 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 10:15:44 INFO - Return code: 0 10:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:44 INFO - https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:45 INFO - Downloaded 11132285 bytes. 10:15:45 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 10:15:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:45 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 10:15:45 INFO - Return code: 0 10:15:45 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')]} 10:15:45 INFO - https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:15:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:15:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:15:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dU6vXmzrRSmgmSROD9BAYg/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 10:15:47 INFO - Downloaded 53374598 bytes. 10:15:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:15:47 INFO - mkdir: /builds/slave/test/properties 10:15:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:47 INFO - Contents: 10:15:47 INFO - build_url:https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:15:47 INFO - Running post-action listener: _resource_record_post_action 10:15:47 INFO - Running post-action listener: set_extra_try_arguments 10:15:47 INFO - ##### 10:15:47 INFO - ##### Running populate-webroot step. 10:15:47 INFO - ##### 10:15:47 INFO - Running pre-action listener: _resource_record_pre_action 10:15:47 INFO - Running main action method: populate_webroot 10:15:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:47 INFO - '--tppagecycles', 10:15:47 INFO - '7'], 10:15:47 INFO - 'tests': ['tsvgm']}}, 10:15:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:15:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:15:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:15:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'tests': ['damp', 'tps']}, 10:15:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['damp', 'tps']}, 10:15:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:15:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:47 INFO - 'other': {'tests': ['a11yr', 10:15:47 INFO - 'ts_paint', 10:15:47 INFO - 'tpaint', 10:15:47 INFO - 'sessionrestore', 10:15:47 INFO - 'sessionrestore_no_auto_restore']}, 10:15:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['a11yr', 10:15:47 INFO - 'ts_paint', 10:15:47 INFO - 'tpaint', 10:15:47 INFO - 'sessionrestore', 10:15:47 INFO - 'sessionrestore_no_auto_restore']}, 10:15:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['a11yr', 10:15:47 INFO - 'ts_paint', 10:15:47 INFO - 'tpaint', 10:15:47 INFO - 'sessionrestore', 10:15:47 INFO - 'sessionrestore_no_auto_restore']}, 10:15:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['a11yr', 10:15:47 INFO - 'ts_paint', 10:15:47 INFO - 'tpaint', 10:15:47 INFO - 'sessionrestore', 10:15:47 INFO - 'sessionrestore_no_auto_restore']}, 10:15:47 INFO - 'other_l64': {'tests': ['a11yr', 10:15:47 INFO - 'ts_paint', 10:15:47 INFO - 'tpaint', 10:15:47 INFO - 'sessionrestore', 10:15:47 INFO - 'sessionrestore_no_auto_restore']}, 10:15:47 INFO - 'other_nol64': {'tests': ['a11yr', 10:15:47 INFO - 'ts_paint', 10:15:47 INFO - 'tpaint', 10:15:47 INFO - 'sessionrestore', 10:15:47 INFO - 'sessionrestore_no_auto_restore']}, 10:15:47 INFO - 'svgr': {'tests': ['tsvgx', 10:15:47 INFO - 'tsvgr_opacity', 10:15:47 INFO - 'tart', 10:15:47 INFO - 'tscrollx', 10:15:47 INFO - 'cart']}, 10:15:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['tsvgx', 10:15:47 INFO - 'tsvgr_opacity', 10:15:47 INFO - 'tart', 10:15:47 INFO - 'tscrollx', 10:15:47 INFO - 'cart']}, 10:15:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'tests': ['tp5o']}, 10:15:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'talos_options': ['--e10s'], 10:15:47 INFO - 'tests': ['tp5o']}, 10:15:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'talos_options': ['--xperf_path', 10:15:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:47 INFO - 'tests': ['tp5n']}, 10:15:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:47 INFO - 'talos_options': ['--e10s', 10:15:47 INFO - '--xperf_path', 10:15:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:47 INFO - 'tests': ['tp5n']}}, 10:15:47 INFO - 'talos.zip': {'path': '', 10:15:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:47 INFO - Running post-action listener: _resource_record_post_action 10:15:47 INFO - ##### 10:15:47 INFO - ##### Running create-virtualenv step. 10:15:47 INFO - ##### 10:15:47 INFO - Running pre-action listener: _resource_record_pre_action 10:15:47 INFO - Running main action method: create_virtualenv 10:15:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:15:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:47 INFO - Using real prefix '/usr' 10:15:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:50 INFO - Installing pip.................done. 10:15:50 INFO - Return code: 0 10:15:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:15:50 INFO - Using env: {'DISPLAY': ':0', 10:15:50 INFO - 'HOME': '/home/cltbld', 10:15:50 INFO - 'LANG': 'en_US.UTF-8', 10:15:50 INFO - 'LANGUAGE': 'en_US:en', 10:15:50 INFO - 'LOGNAME': 'cltbld', 10:15:50 INFO - 'MAIL': '/var/mail/cltbld', 10:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:50 INFO - 'MOZ_NO_REMOTE': '1', 10:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:50 INFO - 'NO_EM_RESTART': '1', 10:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:50 INFO - 'PWD': '/builds/slave/test', 10:15:50 INFO - 'SHELL': '/bin/bash', 10:15:50 INFO - 'SHLVL': '1', 10:15:50 INFO - 'TERM': 'linux', 10:15:50 INFO - 'TMOUT': '86400', 10:15:50 INFO - 'USER': 'cltbld', 10:15:50 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:50 INFO - '_': '/tools/buildbot/bin/python'} 10:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:15:50 INFO - Cleaning up... 10:15:50 INFO - Return code: 0 10:15:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:15:50 INFO - Using env: {'DISPLAY': ':0', 10:15:50 INFO - 'HOME': '/home/cltbld', 10:15:50 INFO - 'LANG': 'en_US.UTF-8', 10:15:50 INFO - 'LANGUAGE': 'en_US:en', 10:15:50 INFO - 'LOGNAME': 'cltbld', 10:15:50 INFO - 'MAIL': '/var/mail/cltbld', 10:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:50 INFO - 'MOZ_NO_REMOTE': '1', 10:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:50 INFO - 'NO_EM_RESTART': '1', 10:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:50 INFO - 'PWD': '/builds/slave/test', 10:15:50 INFO - 'SHELL': '/bin/bash', 10:15:50 INFO - 'SHLVL': '1', 10:15:50 INFO - 'TERM': 'linux', 10:15:50 INFO - 'TMOUT': '86400', 10:15:50 INFO - 'USER': 'cltbld', 10:15:50 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:50 INFO - '_': '/tools/buildbot/bin/python'} 10:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:50 INFO - Downloading/unpacking psutil>=0.7.1 10:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:15:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:52 INFO - Installing collected packages: psutil 10:15:52 INFO - Running setup.py install for psutil 10:15:52 INFO - building 'psutil._psutil_linux' extension 10:15:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:15:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:15:52 INFO - building 'psutil._psutil_posix' extension 10:15:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:15:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:52 INFO - Successfully installed psutil 10:15:52 INFO - Cleaning up... 10:15:52 INFO - Return code: 0 10:15:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:15:52 INFO - Using env: {'DISPLAY': ':0', 10:15:52 INFO - 'HOME': '/home/cltbld', 10:15:52 INFO - 'LANG': 'en_US.UTF-8', 10:15:52 INFO - 'LANGUAGE': 'en_US:en', 10:15:52 INFO - 'LOGNAME': 'cltbld', 10:15:52 INFO - 'MAIL': '/var/mail/cltbld', 10:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:52 INFO - 'MOZ_NO_REMOTE': '1', 10:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:52 INFO - 'NO_EM_RESTART': '1', 10:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:52 INFO - 'PWD': '/builds/slave/test', 10:15:52 INFO - 'SHELL': '/bin/bash', 10:15:52 INFO - 'SHLVL': '1', 10:15:52 INFO - 'TERM': 'linux', 10:15:52 INFO - 'TMOUT': '86400', 10:15:52 INFO - 'USER': 'cltbld', 10:15:52 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:52 INFO - '_': '/tools/buildbot/bin/python'} 10:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:15:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:15:54 INFO - Installing collected packages: mozsystemmonitor 10:15:54 INFO - Running setup.py install for mozsystemmonitor 10:15:54 INFO - Successfully installed mozsystemmonitor 10:15:54 INFO - Cleaning up... 10:15:54 INFO - Return code: 0 10:15:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:15:54 INFO - Using env: {'DISPLAY': ':0', 10:15:54 INFO - 'HOME': '/home/cltbld', 10:15:54 INFO - 'LANG': 'en_US.UTF-8', 10:15:54 INFO - 'LANGUAGE': 'en_US:en', 10:15:54 INFO - 'LOGNAME': 'cltbld', 10:15:54 INFO - 'MAIL': '/var/mail/cltbld', 10:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:54 INFO - 'MOZ_NO_REMOTE': '1', 10:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:54 INFO - 'NO_EM_RESTART': '1', 10:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:54 INFO - 'PWD': '/builds/slave/test', 10:15:54 INFO - 'SHELL': '/bin/bash', 10:15:54 INFO - 'SHLVL': '1', 10:15:54 INFO - 'TERM': 'linux', 10:15:54 INFO - 'TMOUT': '86400', 10:15:54 INFO - 'USER': 'cltbld', 10:15:54 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:54 INFO - '_': '/tools/buildbot/bin/python'} 10:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:55 INFO - Downloading/unpacking blobuploader==1.2.4 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:56 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:57 INFO - Downloading docopt-0.6.1.tar.gz 10:15:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:57 INFO - Running setup.py install for blobuploader 10:15:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:57 INFO - Running setup.py install for requests 10:15:58 INFO - Running setup.py install for docopt 10:15:58 INFO - Successfully installed blobuploader requests docopt 10:15:58 INFO - Cleaning up... 10:15:58 INFO - Return code: 0 10:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:58 INFO - Using env: {'DISPLAY': ':0', 10:15:58 INFO - 'HOME': '/home/cltbld', 10:15:58 INFO - 'LANG': 'en_US.UTF-8', 10:15:58 INFO - 'LANGUAGE': 'en_US:en', 10:15:58 INFO - 'LOGNAME': 'cltbld', 10:15:58 INFO - 'MAIL': '/var/mail/cltbld', 10:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:58 INFO - 'MOZ_NO_REMOTE': '1', 10:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:58 INFO - 'NO_EM_RESTART': '1', 10:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:58 INFO - 'PWD': '/builds/slave/test', 10:15:58 INFO - 'SHELL': '/bin/bash', 10:15:58 INFO - 'SHLVL': '1', 10:15:58 INFO - 'TERM': 'linux', 10:15:58 INFO - 'TMOUT': '86400', 10:15:58 INFO - 'USER': 'cltbld', 10:15:58 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:58 INFO - '_': '/tools/buildbot/bin/python'} 10:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:58 INFO - Running setup.py (path:/tmp/pip-7Fo_Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:58 INFO - Running setup.py (path:/tmp/pip-xwaQXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:58 INFO - Running setup.py (path:/tmp/pip-4Mw_oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:58 INFO - Running setup.py (path:/tmp/pip-dHicPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:58 INFO - Running setup.py (path:/tmp/pip-FIBFRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:58 INFO - Running setup.py (path:/tmp/pip-qqoeY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:58 INFO - Running setup.py (path:/tmp/pip-xsR5zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:58 INFO - Running setup.py (path:/tmp/pip-GFhJCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:58 INFO - Running setup.py (path:/tmp/pip-Glz0Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:59 INFO - Running setup.py (path:/tmp/pip-78d0Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:59 INFO - Running setup.py (path:/tmp/pip-FPTbKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:59 INFO - Running setup.py (path:/tmp/pip-uqjJr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:59 INFO - Running setup.py (path:/tmp/pip-24L2Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:59 INFO - Running setup.py (path:/tmp/pip-Kez226-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:59 INFO - Running setup.py (path:/tmp/pip-wRaD_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:59 INFO - Running setup.py (path:/tmp/pip-JOwAQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:59 INFO - Running setup.py (path:/tmp/pip-Rruywt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:59 INFO - Running setup.py install for manifestparser 10:15:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:59 INFO - Running setup.py install for mozcrash 10:15:59 INFO - Running setup.py install for mozdebug 10:15:59 INFO - Running setup.py install for mozdevice 10:16:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozfile 10:16:00 INFO - Running setup.py install for mozhttpd 10:16:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozinfo 10:16:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozInstall 10:16:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozleak 10:16:00 INFO - Running setup.py install for mozlog 10:16:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for moznetwork 10:16:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozprocess 10:16:00 INFO - Running setup.py install for mozprofile 10:16:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:00 INFO - Running setup.py install for mozrunner 10:16:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:01 INFO - Running setup.py install for mozscreenshot 10:16:01 INFO - Running setup.py install for moztest 10:16:01 INFO - Running setup.py install for mozversion 10:16:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:01 INFO - Cleaning up... 10:16:01 INFO - Return code: 0 10:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:16:01 INFO - Using env: {'DISPLAY': ':0', 10:16:01 INFO - 'HOME': '/home/cltbld', 10:16:01 INFO - 'LANG': 'en_US.UTF-8', 10:16:01 INFO - 'LANGUAGE': 'en_US:en', 10:16:01 INFO - 'LOGNAME': 'cltbld', 10:16:01 INFO - 'MAIL': '/var/mail/cltbld', 10:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:01 INFO - 'MOZ_NO_REMOTE': '1', 10:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:01 INFO - 'NO_EM_RESTART': '1', 10:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:01 INFO - 'PWD': '/builds/slave/test', 10:16:01 INFO - 'SHELL': '/bin/bash', 10:16:01 INFO - 'SHLVL': '1', 10:16:01 INFO - 'TERM': 'linux', 10:16:01 INFO - 'TMOUT': '86400', 10:16:01 INFO - 'USER': 'cltbld', 10:16:01 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:01 INFO - '_': '/tools/buildbot/bin/python'} 10:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:01 INFO - Running setup.py (path:/tmp/pip-6rZ1mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:01 INFO - Running setup.py (path:/tmp/pip-lt5dpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:01 INFO - Running setup.py (path:/tmp/pip-qTMr4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:01 INFO - Running setup.py (path:/tmp/pip-U2cuyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:01 INFO - Running setup.py (path:/tmp/pip-X4uFne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:02 INFO - Running setup.py (path:/tmp/pip-NjapxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:02 INFO - Running setup.py (path:/tmp/pip-wCIssH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:02 INFO - Running setup.py (path:/tmp/pip-2HzNXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:02 INFO - Running setup.py (path:/tmp/pip-Wl6DH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:02 INFO - Running setup.py (path:/tmp/pip-_wq8fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:02 INFO - Running setup.py (path:/tmp/pip-Z71Ukn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:02 INFO - Running setup.py (path:/tmp/pip-1L4O3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:02 INFO - Running setup.py (path:/tmp/pip-0eeaK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:02 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)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:02 INFO - Running setup.py (path:/tmp/pip-Q5bcqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:02 INFO - Running setup.py (path:/tmp/pip-AKfVxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:02 INFO - Running setup.py (path:/tmp/pip-jFPXgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:02 INFO - Running setup.py (path:/tmp/pip-ZwktAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:04 INFO - Downloading blessings-1.5.1.tar.gz 10:16:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:04 INFO - Installing collected packages: blessings 10:16:04 INFO - Running setup.py install for blessings 10:16:04 INFO - Successfully installed blessings 10:16:04 INFO - Cleaning up... 10:16:04 INFO - Return code: 0 10:16:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:05 INFO - Reading from file tmpfile_stdout 10:16:05 INFO - Current package versions: 10:16:05 INFO - argparse == 1.2.1 10:16:05 INFO - blessings == 1.5.1 10:16:05 INFO - blobuploader == 1.2.4 10:16:05 INFO - docopt == 0.6.1 10:16:05 INFO - manifestparser == 1.1 10:16:05 INFO - mozInstall == 1.12 10:16:05 INFO - mozcrash == 0.16 10:16:05 INFO - mozdebug == 0.1 10:16:05 INFO - mozdevice == 0.47 10:16:05 INFO - mozfile == 1.2 10:16:05 INFO - mozhttpd == 0.7 10:16:05 INFO - mozinfo == 0.9 10:16:05 INFO - mozleak == 0.1 10:16:05 INFO - mozlog == 3.1 10:16:05 INFO - moznetwork == 0.27 10:16:05 INFO - mozprocess == 0.22 10:16:05 INFO - mozprofile == 0.28 10:16:05 INFO - mozrunner == 6.11 10:16:05 INFO - mozscreenshot == 0.1 10:16:05 INFO - mozsystemmonitor == 0.0 10:16:05 INFO - moztest == 0.7 10:16:05 INFO - mozversion == 1.4 10:16:05 INFO - psutil == 3.1.1 10:16:05 INFO - requests == 1.2.3 10:16:05 INFO - wsgiref == 0.1.2 10:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:16:05 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 10:16:05 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 10:16:05 INFO - Using env: {'DISPLAY': ':0', 10:16:05 INFO - 'HOME': '/home/cltbld', 10:16:05 INFO - 'LANG': 'en_US.UTF-8', 10:16:05 INFO - 'LANGUAGE': 'en_US:en', 10:16:05 INFO - 'LOGNAME': 'cltbld', 10:16:05 INFO - 'MAIL': '/var/mail/cltbld', 10:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:05 INFO - 'MOZ_NO_REMOTE': '1', 10:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:05 INFO - 'NO_EM_RESTART': '1', 10:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:05 INFO - 'PWD': '/builds/slave/test', 10:16:05 INFO - 'SHELL': '/bin/bash', 10:16:05 INFO - 'SHLVL': '1', 10:16:05 INFO - 'TERM': 'linux', 10:16:05 INFO - 'TMOUT': '86400', 10:16:05 INFO - 'USER': 'cltbld', 10:16:05 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:05 INFO - '_': '/tools/buildbot/bin/python'} 10:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:05 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)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:16:05 INFO - Cleaning up... 10:16:05 INFO - Return code: 0 10:16:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:16:05 INFO - Using env: {'DISPLAY': ':0', 10:16:05 INFO - 'HOME': '/home/cltbld', 10:16:05 INFO - 'LANG': 'en_US.UTF-8', 10:16:05 INFO - 'LANGUAGE': 'en_US:en', 10:16:05 INFO - 'LOGNAME': 'cltbld', 10:16:05 INFO - 'MAIL': '/var/mail/cltbld', 10:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:05 INFO - 'MOZ_NO_REMOTE': '1', 10:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:05 INFO - 'NO_EM_RESTART': '1', 10:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:05 INFO - 'PWD': '/builds/slave/test', 10:16:05 INFO - 'SHELL': '/bin/bash', 10:16:05 INFO - 'SHLVL': '1', 10:16:05 INFO - 'TERM': 'linux', 10:16:05 INFO - 'TMOUT': '86400', 10:16:05 INFO - 'USER': 'cltbld', 10:16:05 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:05 INFO - '_': '/tools/buildbot/bin/python'} 10:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:05 INFO - Downloading/unpacking jsonschema 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 10:16:07 INFO - Downloading/unpacking functools32 (from jsonschema) 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:07 INFO - warning: no files found matching '*.txt' 10:16:07 INFO - no previously-included directories found matching 'build' 10:16:07 INFO - no previously-included directories found matching 'dist' 10:16:07 INFO - no previously-included directories found matching '.git*' 10:16:07 INFO - Installing collected packages: jsonschema, functools32 10:16:07 INFO - Running setup.py install for functools32 10:16:07 INFO - warning: no files found matching '*.txt' 10:16:07 INFO - no previously-included directories found matching 'build' 10:16:07 INFO - no previously-included directories found matching 'dist' 10:16:07 INFO - no previously-included directories found matching '.git*' 10:16:07 INFO - Successfully installed jsonschema functools32 10:16:07 INFO - Cleaning up... 10:16:07 INFO - Return code: 0 10:16:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042e1f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, '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': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', '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 10:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:16:07 INFO - Using env: {'DISPLAY': ':0', 10:16:07 INFO - 'HOME': '/home/cltbld', 10:16:07 INFO - 'LANG': 'en_US.UTF-8', 10:16:07 INFO - 'LANGUAGE': 'en_US:en', 10:16:07 INFO - 'LOGNAME': 'cltbld', 10:16:07 INFO - 'MAIL': '/var/mail/cltbld', 10:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:07 INFO - 'MOZ_NO_REMOTE': '1', 10:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:07 INFO - 'NO_EM_RESTART': '1', 10:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:07 INFO - 'PWD': '/builds/slave/test', 10:16:07 INFO - 'SHELL': '/bin/bash', 10:16:07 INFO - 'SHLVL': '1', 10:16:07 INFO - 'TERM': 'linux', 10:16:07 INFO - 'TMOUT': '86400', 10:16:07 INFO - 'USER': 'cltbld', 10:16:07 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:07 INFO - '_': '/tools/buildbot/bin/python'} 10:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:07 INFO - Downloading/unpacking flake8 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:16:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 10:16:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:16:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:16:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 10:16:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:10 INFO - no previously-included directories found matching 'docs/_build' 10:16:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:16:10 INFO - Running setup.py install for pep8 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:10 INFO - no previously-included directories found matching 'docs/_build' 10:16:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:16:10 INFO - Cleaning up... 10:16:10 INFO - Return code: 0 10:16:10 INFO - Running post-action listener: _resource_record_post_action 10:16:10 INFO - Running post-action listener: _start_resource_monitoring 10:16:10 INFO - Starting resource monitoring. 10:16:10 INFO - ##### 10:16:10 INFO - ##### Running install step. 10:16:10 INFO - ##### 10:16:10 INFO - Running pre-action listener: _resource_record_pre_action 10:16:10 INFO - Running main action method: install 10:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:10 INFO - Reading from file tmpfile_stdout 10:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:10 INFO - Reading from file tmpfile_stdout 10:16:10 INFO - Output received: 10:16:10 INFO - Usage: mozinstall [options] installer 10:16:10 INFO - Options: 10:16:10 INFO - -h, --help show this help message and exit 10:16:10 INFO - -d DEST, --destination=DEST 10:16:10 INFO - Directory to install application into. [default: 10:16:10 INFO - "/builds/slave/test"] 10:16:10 INFO - --app=APP Application being installed. [default: firefox] 10:16:10 INFO - mkdir: /builds/slave/test/build/application 10:16:10 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'] 10:16:10 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 10:16:26 INFO - Reading from file tmpfile_stdout 10:16:26 INFO - Output received: 10:16:26 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:26 INFO - Running post-action listener: _resource_record_post_action 10:16:26 INFO - ##### 10:16:26 INFO - ##### Running run-tests step. 10:16:26 INFO - ##### 10:16:26 INFO - Running pre-action listener: _resource_record_pre_action 10:16:26 INFO - Running main action method: run_tests 10:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:26 INFO - Python 2.7.3 10:16:26 INFO - Return code: 0 10:16:26 INFO - grabbing minidump binary from tooltool 10:16: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')]} 10:16:26 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 0x28113d0>, '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 0x277ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277d360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:26 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 10:16:26 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 10:16:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:26 INFO - Return code: 0 10:16:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:16:27 INFO - Return code: 0 10:16:27 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:16:27 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:16:27 INFO - Using env: {'DISPLAY': ':0', 10:16:27 INFO - 'HOME': '/home/cltbld', 10:16:27 INFO - 'LANG': 'en_US.UTF-8', 10:16:27 INFO - 'LANGUAGE': 'en_US:en', 10:16:27 INFO - 'LOGNAME': 'cltbld', 10:16:27 INFO - 'MAIL': '/var/mail/cltbld', 10:16:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:27 INFO - 'MOZ_NO_REMOTE': '1', 10:16:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:27 INFO - 'NO_EM_RESTART': '1', 10:16:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:27 INFO - 'PWD': '/builds/slave/test', 10:16:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:27 INFO - 'SHELL': '/bin/bash', 10:16:27 INFO - 'SHLVL': '1', 10:16:27 INFO - 'TERM': 'linux', 10:16:27 INFO - 'TMOUT': '86400', 10:16:27 INFO - 'USER': 'cltbld', 10:16:27 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1451499247.947410-228029518', 10:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:27 INFO - '_': '/tools/buildbot/bin/python'} 10:16:27 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:16:27 INFO - mozversion application_buildid: 20151230093737 10:16:27 INFO - mozversion application_changeset: 63227efdffeffc2b8dc6f0fc999c13809b753a43 10:16:27 INFO - mozversion application_display_name: Nightly 10:16:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:27 INFO - mozversion application_name: Firefox 10:16:27 INFO - mozversion application_remotingname: firefox 10:16:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:16:27 INFO - mozversion application_vendor: Mozilla 10:16:27 INFO - mozversion application_version: 46.0a1 10:16:27 INFO - mozversion platform_buildid: 20151230093737 10:16:27 INFO - mozversion platform_changeset: 63227efdffeffc2b8dc6f0fc999c13809b753a43 10:16:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:16:27 INFO - mozversion platform_version: 46.0a1 10:16:27 INFO - using testdate: 1451499387 10:16:27 INFO - actual date: 1451499387 10:16:27 INFO - starting webserver on 'localhost:32911' 10:16:27 INFO - SUITE-START | Running 3 tests 10:16:27 INFO - TEST-START | dromaeo_css 10:16:27 INFO - operating with platform_type : linux_ 10:16:27 INFO - Initialising browser for dromaeo_css test... 10:16:27 INFO - TEST-INFO | started process 5504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7zy3r/profile http://localhost:32911/getInfo.html) 10:16:31 INFO - PROCESS | 5504 | __metrics Screen width/height:1600/1200 10:16:31 INFO - PROCESS | 5504 | colorDepth:24 10:16:31 INFO - PROCESS | 5504 | Browser inner width/height: 1024/697 10:16:31 INFO - PROCESS | 5504 | __metrics 10:16:31 INFO - PROCESS | 5504 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:16:31 INFO - PROCESS | 5504 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:32 INFO - TEST-INFO | 5504: exit 0 10:16:32 INFO - Browser initialized. 10:16:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:32 INFO - TEST-INFO | started process 5596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7zy3r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:44 INFO - PROCESS | 5596 | RSS: Main: 149577728 10:16:44 INFO - PROCESS | 5596 | 10:17:35 INFO - PROCESS | 5596 | 1451499455840 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] 10:19:47 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:32911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32911/tests/dromaeo/cssquery-ext.html) 10:19:48 INFO - PROCESS | 5596 | RSS: Main: 247545856 10:19:48 INFO - PROCESS | 5596 | 10:22:51 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:32911/tests/dromaeo/cssquery-ext.html (next: http://localhost:32911/tests/dromaeo/cssquery-jquery.html) 10:22:51 INFO - PROCESS | 5596 | RSS: Main: 228216832 10:22:51 INFO - PROCESS | 5596 | 10:25:53 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:32911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32911/tests/dromaeo/cssquery-mootools.html) 10:25:54 INFO - PROCESS | 5596 | RSS: Main: 219955200 10:25:54 INFO - PROCESS | 5596 | 10:28:56 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:32911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32911/tests/dromaeo/cssquery-prototype.html) 10:28:57 INFO - PROCESS | 5596 | RSS: Main: 211513344 10:28:57 INFO - PROCESS | 5596 | 10:31:59 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:32911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32911/tests/dromaeo/cssquery-yui.html) 10:32:00 INFO - PROCESS | 5596 | RSS: Main: 214695936 10:32:00 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:32911/tests/dromaeo/cssquery-yui.html (next: http://localhost:32911/tests/dromaeo/cssquery-dojo.html) 10:35:03 INFO - PROCESS | 5596 | RSS: Main: 261980160 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | __start_tp_report 10:35:03 INFO - PROCESS | 5596 | _x_x_mozilla_page_load 10:35:03 INFO - PROCESS | 5596 | _x_x_mozilla_page_load_details 10:35:03 INFO - PROCESS | 5596 | |i|pagename|runs| 10:35:03 INFO - PROCESS | 5596 | |0;dojo.html;2592.805539584531;2683.3157544826067;2686.7850571954245;2691.380982374054;2713.0233116078207;4456.732596044231;4544.068465964478;4602.19461594221;4621.260598304272;4630.4906460289385;4621.12198682251;4628.1669299526075;4630.722156670602;4750.9049819003685;4764.880877978052;4257.14857028594;4329.480462344507;4332.371806088116;4353.695241333108;4416.80124394403;4215.473065866767;4266.7866606669695;4330.004099057219;4346.391505189276;4347.500037495681;4157.875263742093;4260.680448966309;4299.441072660534;4347.84782532613;4358.0412309291905;4266.338717498793;4349.956500434987;4354.150940566591;4356.542563030868;4378.277584198603;4263.019505513718;4279.443672322609;4285.164392943378;4293.849715259982;4322.0491491871735;4376.212281789277;4467.843625473125;4485.035717320791;4592.954070459286;4626.444826620794;4956.479569645171;5012;5042.899142017176;5072.036313100499;5074.695518268879;5057.165567681328;5062.594992400599;5065.873353166164;5117.692938423706;5117.872053198663;4459.910801783946;4556.521565235669;4696.060787842445;4704.717716936994;4707.7175369477945;4968.90062198754;5031.748412579356;5094.566961808214;5138.3577052868395;5142.331496905378;4863.927041094386;4871.342368780241;4872.9512704872495;4873.049755297754;4911.091448082045;4747.359106520645;4853.927191092136;4956.801727930842;4965.652404331734;4979.6265280104135;4813.95186048142;4908.04293162837;4981.975090124526;5002.274670172877;5038.067957427887;4930.975345123252;4940.777665005084;4947.208446648519;4950.886050638577;4993.101241776442;3931.095847954929;4036.8183431745642;4161.3549899765585;4170.061736109412;4208.137331846964;3582.7671201371827;3595.7123430125525;3642.508261384732;3670.7981061041364;3687.022938921188;4250.787460626956;4288.935665965013;4290.056187638715;4290.528041915387;4321.5678432157165;4731.574158325699;4836.274558816135;4927.260910863328;4954.157793175169;5005.824796132118;4135.937960930589;4241.915161696748;4316.805743741539;4325.070109926318;4350.58669426404;4411.338299255138;4414.646828253732;4416.80124394403;4421.690481666253;4448;4553.2259515881715;4658.930116048195;4716.952830471651;4720.811167553259;4723.480417154179;4855.757212139309;4937.703737775745;5038.47096054909;5050.292958985671;5061.9493805061475;4717.363155974037;4725.645576581839;4730.219513780187;4730.266808644666;4772.7136371817805;4895.118878601886;4915.877103072452;4918.262260660929;4920.532549407801;4949.109160351028;4807.879803004813;4915.729634870117;4926.310316555613;4933.703977761345;5073.6955782651685;4814.374131362901;4825.565699087099;4831.492693267156;4832.371791667061;4864.829730959399;4793.13723529754;4794.041191761731;4798.712077275374;4800.831970881002;4838.371011768589;4495.977520112378;4608.239640459286;4608.423947006624;4609.032103258353;4681.531846815291;4854.344663470528;4858.222684370625;4859.1010663027455;4894.657373983787;4899.069176856386;4729.243321068612;4733.573978341966;4738.194506933898;4745.169595320736;4783.760811959458 10:35:03 INFO - PROCESS | 5596 | |1;ext.html;455.1715877103671;461.709123252351;487.6854428893364;502.3946144895401;535.7214248590733;20813.583728325444;32301.192470188256;33025.66974330262;33117.83441082791;33199.33601327972;36712.81643591785;36863;37090.814545927235;37220.06949826256;37223.255534889286;6577.651581425796;6675.399214070732;7598.278163574465;7757;7765.728199513018;9654.420734755937;9858.753531161743;9872.45701486418;9885.308028438012;9890.357126786736;9619.374740641872;9714.36856604322;9722.756931076745;9728;9732.10224006319;6789.355011273897;6917.619530925797;9574.377665451793;9636.084571965652;9779.706608801676;9329.253659707207;9457.527123643791;9458.763530911714;9486.90513094874;9490.810183796355;32761;33241;33251.6674833251;33328.6667133328;33493;2764.2951047482966;2967.940641187186;3050.496668049769;3487.860485580574;3528;25309;26700.73299267002;26720;26721.331966700793;27416.177514674593;3477.6522347765276;3526.347625689256;3547.929041419183;3604.4953706481115;3613.3495970725257;222507;223808;224985;225118;225457;35142.64857351445;35762;54987.72506137444;55306.446935530126;55841.7207913966;49276.50723492791;49511.25733114006;49542;49566.25650615244;49778;11446.313221206754;11653.41732913351;11687.357195354167;11715.062794976382;11728.472218750177;8921.375503714808;9004.50475223856;9009.324300677476;9013.819723605491;9014.774630634156;18860.434186974413;18988.620227595646;19055.237790488503;19138.23447062102;19150.882560249614;7378.40972722181;7683.231676832272;7897.328727058264;7941.761747147595;8027.237412445808;827.755812035451;829.6930135849774;878.2403221213605;942.7218970403748;1031.2729525684374;26137.215883523524;26165.345866353113;26470;26675;27635.170944871687;915.5102020419178;916.5783739479914;983.9655612053543;994.4629899853998;1022.5551884930079;14618.780718289234;15460.149691766836;16099.67800644004;16219.51341459758;16224.107674077803;335871;339837;341778;341787;342144;33009.83495082509;46770.766146169735;47171;47181.76409117933;47270.76364618224;957.3777044920857;1178.7171078941165;1216.239850093709;1219.3293688471306;1223.0460241012024;26270;26413.867930660224;26660.200193994213;27147.59278610862;27226.591601126394;26352.60471092897;27162.592561111993;36979.63020369762;37057;37772.24455510819;194620;195770;197595;197653;198080;27101.72898270992;27422.177334679993;27452.45095098047;27478.313042173308;27505.724942750316;35418.64581354154;36053.81973090223;36217.63782362143;36533.269334612625;37041.25917481689;32192.83903580467;32859.67140328566;33569.16077098092;33872.66127338695;34067.65932340645;32907.341853163285;33081.50377744384;33253;33359.49960750542;33392.833035834665;32695.673043269264;32936.34127317488;32980.67019329872;33400.49899251562;33406.164845879044;29348.559771603017;29735.256618583844;30704.385912282076;30839;30863.382732345675;23618.881905590362;23682.289531314087;23714.52570948537;23849.403764906016;23871.40321491907 10:35:03 INFO - PROCESS | 5596 | |2;jquery.html;333.4631243697646;334.43313583476004;335.1437078265033;335.3862431749898;335.85893924551686;11476.942615286933;11854.3480108594;14776.6305842354;15140.621484462894;15567.610809729762;9421;9483.099105584975;9791.167750741177;9792.16766574842;9804.901950980488;4409.757463339515;4528.252838281696;4528.615067719248;4533.387992620987;4535.024969631545;3420.2133509292876;3515.2617950230356;4457.48738895028;4988.401391832967;5124.385073791151;5082.745862706868;5100.719460429675;5103.3875934887865;5122.513361230677;5127.461616530267;5069.74651267437;5092.79628814847;5475.0966090595;5480.862978425532;5484.972575137099;4838.419389673261;4859.71217627329;4881.780319885614;4883.853484395474;4886.193778026622;17760.3783867564;18489.352872649393;18507.167177477048;19157.712634310497;19200;1834.0737927346738;1871.073818459871;1907.0464767616193;1930.2664987304875;1942.8931408772512;6000.579959402844;6014.097885317194;8554.572271386469;8750.299976001905;9112.817743645157;1619.4817658349332;1770.1414813815288;1800.3518733256017;1804.1159831682512;1829.2957211473679;52873;54407;56726.71636641832;57972.42027579712;59435.108473373366;14751.967362284537;14875.628109297139;15820.841791581937;16056.518304450885;16248.350065997227;22574.435639109153;22649.660255096187;22835.086596536286;22847;22901.427464313194;7148.535345202546;7213.278672132849;7237.384822290059;7418.1825452764415;7890.842183156305;6250.124982502453;6452.419282264619;6458.838529036811;6474.611523308617;6531.216254049449;7603.467757256939;7814.843703125905;7833.529988200727;7838.451308408356;7957.045154581488;1676.6814305281957;1708.871834612409;1728.6801941640836;2060.8047332547085;2931.120663800851;765.8659734546543;815.3640160674684;838.3167718309559;931.29221791439;940.5062342270363;14512.274386280644;15097.698046039017;15656.138912359702;15698.136602486973;15995.920020399824;683.9247682754893;869.8738682890945;882.7263548300048;889.8309321228945;908.5003248213457;8274.255317021498;9039.954800225956;9445.952770236105;9484.810303794024;9674.371165874196;481698.7745183825;483533;486251;490166;492078;72449.63775181091;74155.62922185354;75340.62329688316;75464;75891.62054189693;918.3020904112789;945.2863088368375;946.976325591852;956.3066776587058;1048.8688913885917;13728.45086196541;14246.501372451914;14354.928225359225;14521.86357765811;15015.249237538297;32773.18067048248;33136.66863331432;33737.3252534943;33974.830125849214;34328.656713432545;41879.7906010468;42717.78641106775;42775.3583696251;43115;45785;8328.500289982621;8496.150384961455;8501.702440414803;8502.107278735644;8551.871721924052;9801.46165641121;16405.42581009659;16715;16739.66520669604;16933.57666058309;13685.521006764715;13990.300484975507;14142.22217778032;14175.149491030572;14314.069585476911;13311.800322995357;13392;13578.86421135776;13670.436284148705;13899.791503127259;13550.186988780704;13620.709476514867;13706.109102908278;14258.857411425754;14595.92702036483;6633.237177724431;6830.556013859084;8637.179467950535;8881.333899957399;9007.594658240527;13209.603711888658;13239.139455935334;13625.523106691218;13661.86338136606;13689.31553422305 10:35:03 INFO - PROCESS | 5596 | |3;mootools.html;1013.3261381181514;1362.781954887218;1372.807806907033;1473.9410423583058;1702.5403141151883;5802.332731735852;6503.284638689746;6616.206055273368;6630.96684516578;6638.50211234157;6690.498212634047;6842.692078856451;6876.312368763121;6885.965570172155;6896.517243792937;2011.7083022961626;2040.9795902041012;2049.6515592349338;2050.241410678051;2050.425880753384;2002.5894691588262;2029.502771820906;2033.4103110098129;2046.774854765982;2047.119738512439;2021.858469907107;2034.2676636410881;2056.578401427711;2058.1047244448637;2058.7632422271404;2005.1578337098454;2038.4190505705876;2039.6430624640777;2041.101915157326;2043.2031507712004;2021.858469907107;2054.4658388819016;2068.2244158440585;2069.98965005174;2072.7305450291515;6858.074159988388;6921.48088893335;6931.896021559681;6935.237123916365;6936.167659880796;3882.145927895858;3936.0356712605308;3937.2125574885135;3953.920921581552;3957.584453632356;2643.973560264392;2657;2696.6359541461848;2738.2606696191915;2760.6135141080063;814.4339683919678;818.7789296889866;825.22428916818;853.8249658819989;858.3648100405717;9171.358004939657;9178.81642367149;9217;9219.492927888963;9223;3754.249150169977;3764.416515440111;3790.4882840816135;3820.5033345665443;3830.961690383116;7789.766307010798;7799.610019499002;7812.375009999187;7822.452428330076;7827.726029589051;4026.57720939303;4032.0927791246736;4038.030872590557;4045;4052.594740525924;2999.6700362960055;3051.06942382571;3466.6360032196762;3651.470536772153;3657.6342365763744;3350.3131857969056;3369.663033696611;3382.1713680148027;3407.522946787452;3409.5226668266464;1036.2435422141878;1043.2697112021615;1054.583439541377;1056.8731752189785;1078.8813230544633;736.9520981136209;780.9414293927978;932.1936524905908;951.9809603807885;991.6380521109743;5921.141434491975;6037.849053773603;6038.728257228435;6039.818805435844;6059.091136329585;1005.8139244239838;1005.9547320370601;1007.4861820471613;1024.8206563851297;1036.3471013261596;4873.439554451284;5000.199968005102;5002.949970500248;5009.248612708123;5012.523810238022;7873.094594121635;8117.107118216992;8274.875876861852;8349.03986041601;8356.749297521084;7938.841223175504;7952.642131104114;8000.279974802295;8025.197480251928;8063.838723225503;6259.78090766821;6300.527460440485;6310.9368906311265;6312.6212427253595;6331.271903731038;6168.383161683975;6289.685515724287;6312.210973628296;6314.55798094129;6322.178116844781;7224.855502890018;7311.853762924606;7370.705171793283;7402.962985185255;7409.703611855681;7408.6666100026705;7463.104427468521;7512.887306690294;7529.3223609873185;7540.509866858637;6230.470410015199;6267.561270711007;6295.496360291074;6311.463525600376;6337.683115844282;6695.899561506679;6712.127423434922;6740.730370785113;6825.419839313714;6835.077264569419;6395.5203359747275;6400.39196276353;6432.099506069248;6440.32376600469;6490.286068532552;5193.195054766517;6069.969650151721;6166.969165154145;6179.134921110958;6333.556651034383;6200.720967556381;6238.313785483502;6247.625142491465;6266.436020758154;6278.717457714505;5712.65724056558;5725.169850371756;5749.770009199585;5750.367459579526;5754.4533269339345;5760.6255593386295;5795.5073818724195;5797.449242321973;5800.042992906292;5800.622959507618 10:35:03 INFO - PROCESS | 5596 | |4;prototype.html;288.6896586169867;296.50631698222463;297.77369199408446;303.76154718545934;305.16689437834725;5225.973870130653;5308.150695888658;5407.702576358303;5412.134058550628;5419.160030195316;5208.401033881105;5364.275822763926;5374.543163831069;5379.462053794618;5384.40771515134;4162.750234985903;4206.47419072616;4208.705390622657;4210.242156411845;4212.915741685165;3926.175503144329;4015.759054456742;4084.7344922580087;4207.095474472988;4207.537170911197;4161.500619925598;4162.83348666053;4165.979170104145;4170.061736109366;4186.434831297782;4161.271777438967;4172.061286210609;4176.895577610554;4177.060161463677;4182.581741825808;3689.1330537323706;3690.5202323698018;3691.077230692327;3691.50164727761;3694.4827724118645;4646.3495110684535;4888.193448081098;5033.546980771712;5203.115470370046;5209.984053109645;4667.253239481666;4686.695364801311;4714.316424118484;4762.047590481918;4809.701380627246;5661.490465858052;5672.205891175238;5684.204211410406;5687.317521897398;5687.886242275173;3714.758540694846;3815.5993620669706;3917.98041009796;4031.5363733170766;4060.776657283848;5895.705214739289;5960.7019649017375;5970.9701451492465;5973.970130149365;5991.370906054845;4125.628693417607;4144.564820693844;4148.108156746253;4153.314703074019;4158.147579746144;4177.958220417818;4189.49726032878;4208.410822484854;4211.915761684749;4212.283911735012;4666.65000124992;4781.187198176249;4781.665283430196;4787.54518320759;4791.377120974251;5662.886742265132;5664.405237450091;5666.829995100154;5672.14917762339;5677.489025987681;1464.0703153497607;1484.3765618440282;1484.8515148485064;1486.6580686442178;1487.4273404739038;1000;1008.4403156248353;1014.6905193915779;1018.709667744704;1027.7790275090892;4985.376827896513;4990.6506544541535;4995.175795993693;4999.65002449825;5002.09962206799;5896.292444906639;5904.114382842608;5907.2911250650195;5911;5911.438413350725;4979.70527662803;4991.101601711727;4992.500749924979;4994.32576602154;4994.475580064113;3097.4424603571124;3156.1162874395204;3174.619045714483;3181.3319202967173;3185.4106990206888;5564.276644036249;5567.359753628303;5574.888502229933;5579.9163012554845;5582.385937546866;6031.125486804389;6044.9395506044375;6049.485793707584;6055.091736239511;6055.939440605625;5440.972795135999;5562.110062389998;5570.136628822539;5571.4428557143965;5574.414686457944;5875.6474611523445;5879.7060146993335;5888.263967004124;5893.086571581412;5897.3807750185615;5537;5671.404502527175;5724.284464441945;5728;5738.053221218619;5457.863553411196;5596.216529685928;5596.804111856066;5604.85987850307;5619.831405057855;4147.419361289361;4148.605882441163;4149.585041495826;4151.086760912594;4153.8961525962095;5931.733072011683;5933.317668468008;5934.347221805511;5935.465808077293;5935.554833387427;5569.443055694398;5703.889560862342;5713.057345538106;5713.314402271754;5763.193152958673;5670.206171135962;5704.914426283692;5713.742881570256;5715.17130016137;5722.341930678025;5514.117741161395;5519.448055194448;5547.306586676666;5552.888942221214;5557.666540007613;5630.211770352236;5749.137629355463;5751.482366587027;5752.424757524214;5763.394843541368;5577.191307260506;5581.413951535031;5584.357798853184;5585.357683866245;5592.217089607377 10:35:03 INFO - PROCESS | 5596 | |5;yui.html;668.7427636044237;679.3546131175383;783.1189911349732;788.5465857132143;819.287220118497;10424.270301078917;10597.947010264937;10614.097801686856;10615.78768424631;10623.893761062387;11576.131790115733;11644.534218631266;11647.534098636044;11678.240914340584;11679.357635330054;476.81404252341616;487.0745583391549;782.6517199846071;787.4133770341103;795.9880601790978;796.6813274690112;796.8366484870587;803.0082847683107;803.5299349880327;803.6504120707511;833.1793183714067;838.3795990966671;839.2530647723531;839.6557411461303;840.0255703384075;457.7185031205801;462.3296220480317;814.6089876859081;828.3994104274414;828.7016673997356;609.7591451376726;612.3967891626744;612.7518355066161;613.0834402568145;615.9928516874942;11059.834102488468;11158;11175.664730058112;11184.888151118466;11186.832197517044;10345.379277243313;10986.121110311156;11015.173861960306;11115.83326250107;11642.76714465706;9040.593173307218;9630.951845240728;9741.610335586569;9887.456189909552;10024;3154.5899033125775;3281.6554261802644;3289.1448223461834;3296.1924328539662;3297.1757060734817;40558.797206014075;41115.794421028004;41219;41815.58184418147;41982;8689.608967596474;9011.63953441868;9168.10349123445;9280.350375473787;9332.58003389849;15887.841121588868;15924.363025478851;15929.283182256826;15934.601634958986;15939.521814345588;6162.291336496361;6175.752969881244;6221.5333849961435;6245.500359971192;6373.872522549523;3510.543629328222;3546;3550.0592343029116;3553.7690050146657;3608.0619039050034;2687.2207059952784;2839.176638774732;2922.503174460347;2927.1803894909035;2929.7802664800224;494.24627443149484;503.87655024518494;511.2357026245712;521.2962500624127;532.4648728028307;408.5159086482528;412.57710846382696;426.098801035807;433.82646941223766;475.7430987266906;6950.478714096463;6971.51199416036;7249.420046396275;7255.383292420098;8133.959330203311;434.63707803983397;448.81598544596557;487.84145152825477;513.125121667556;519.7297405349273;3286.7041966223155;3299.389612921569;3349.34687735894;3505.4566542186003;3521.3485505181625;50379.49620503822;53336.73331633394;53397;53476.73261633667;53500.464995350325;43773.78113109478;44611.33083003757;44762.55237447584;44838.32742508865;46095.539044609795;40767.18465630671;41932.58067419348;42478.78760606177;42569;42599.36100958488;6996.335348141918;7201.3158749918675;7295.52579082358;7319.304666056716;7434.962825185839;30794.384112318075;31167.376652467276;31371.215719607193;31387.68612313939;31781.523277151322;37276.440853387765;37915.43126853044;40257;40796.388054179806;40870.79564602277;8057.556834374166;8450.39442505922;8616.827663446822;8738.781530461789;9230.215431688383;8804.515751633722;9241.168294853496;9303.953480232556;9727.85408218863;9993.150582200304;8310.916890831015;8351.081381048201;8405.95797021011;8486;8575.056743758058;9410.858837117312;9459.148676619137;9490.478023708487;9557.187639050759;9786.804263914824;9201.217896478607;9208.585613647268;9212.49331286759;9264.768380790265;9267.165955064076;7875.488093273919;8010.359171266401;8193.385496087936;8452.661893524437;8568.057513673615;7555;7629.427792915442;7689.92310076892;7789.337906277803;7827.491213071132 10:35:03 INFO - PROCESS | 5596 | __end_tp_report 10:35:03 INFO - PROCESS | 5596 | __start_cc_report 10:35:03 INFO - PROCESS | 5596 | _x_x_mozilla_cycle_collect,955 10:35:03 INFO - PROCESS | 5596 | __end_cc_report 10:35:03 INFO - PROCESS | 5596 | __startTimestamp1451500503353__endTimestamp 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | ------- Summary: start ------- 10:35:03 INFO - PROCESS | 5596 | Number of tests: 6 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | [#0] dojo.html Cycles:165 Average:4581.98 Median:4720.81 stddev:474.68 (10.1%) stddev-sans-first:449.76 10:35:03 INFO - PROCESS | 5596 | Values: 2592.8 2683.3 2686.8 2691.4 2713.0 4456.7 4544.1 4602.2 4621.3 4630.5 4621.1 4628.2 4630.7 4750.9 4764.9 4257.1 4329.5 4332.4 4353.7 4416.8 4215.5 4266.8 4330.0 4346.4 4347.5 4157.9 4260.7 4299.4 4347.8 4358.0 4266.3 4350.0 4354.2 4356.5 4378.3 4263.0 4279.4 4285.2 4293.8 4322.0 4376.2 4467.8 4485.0 4593.0 4626.4 4956.5 5012.0 5042.9 5072.0 5074.7 5057.2 5062.6 5065.9 5117.7 5117.9 4459.9 4556.5 4696.1 4704.7 4707.7 4968.9 5031.7 5094.6 5138.4 5142.3 4863.9 4871.3 4873.0 4873.0 4911.1 4747.4 4853.9 4956.8 4965.7 4979.6 4814.0 4908.0 4982.0 5002.3 5038.1 4931.0 4940.8 4947.2 4950.9 4993.1 3931.1 4036.8 4161.4 4170.1 4208.1 3582.8 3595.7 3642.5 3670.8 3687.0 4250.8 4288.9 4290.1 4290.5 4321.6 4731.6 4836.3 4927.3 4954.2 5005.8 4135.9 4241.9 4316.8 4325.1 4350.6 4411.3 4414.6 4416.8 4421.7 4448.0 4553.2 4658.9 4717.0 4720.8 4723.5 4855.8 4937.7 5038.5 5050.3 5061.9 4717.4 4725.6 4730.2 4730.3 4772.7 4895.1 4915.9 4918.3 4920.5 4949.1 4807.9 4915.7 4926.3 4933.7 5073.7 4814.4 4825.6 4831.5 4832.4 4864.8 4793.1 4794.0 4798.7 4800.8 4838.4 4496.0 4608.2 4608.4 4609.0 4681.5 4854.3 4858.2 4859.1 4894.7 4899.1 4729.2 4733.6 4738.2 4745.2 4783.8 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | [#1] ext.html Cycles:180 Average:40329.17 Median:184871.83 stddev:68492.21 (37.0%) stddev-sans-first:68618.92 10:35:03 INFO - PROCESS | 5596 | Values: 455.2 461.7 487.7 502.4 535.7 20813.6 32301.2 33025.7 33117.8 33199.3 36712.8 36863.0 37090.8 37220.1 37223.3 6577.7 6675.4 7598.3 7757.0 7765.7 9654.4 9858.8 9872.5 9885.3 9890.4 9619.4 9714.4 9722.8 9728.0 9732.1 6789.4 6917.6 9574.4 9636.1 9779.7 9329.3 9457.5 9458.8 9486.9 9490.8 32761.0 33241.0 33251.7 33328.7 33493.0 2764.3 2967.9 3050.5 3487.9 3528.0 25309.0 26700.7 26720.0 26721.3 27416.2 3477.7 3526.3 3547.9 3604.5 3613.3 222507.0 223808.0 224985.0 225118.0 225457.0 35142.6 35762.0 54987.7 55306.4 55841.7 49276.5 49511.3 49542.0 49566.3 49778.0 11446.3 11653.4 11687.4 11715.1 11728.5 8921.4 9004.5 9009.3 9013.8 9014.8 18860.4 18988.6 19055.2 19138.2 19150.9 7378.4 7683.2 7897.3 7941.8 8027.2 827.8 829.7 878.2 942.7 1031.3 26137.2 26165.3 26470.0 26675.0 27635.2 915.5 916.6 984.0 994.5 1022.6 14618.8 15460.1 16099.7 16219.5 16224.1 335871.0 339837.0 341778.0 341787.0 342144.0 33009.8 46770.8 47171.0 47181.8 47270.8 957.4 1178.7 1216.2 1219.3 1223.0 26270.0 26413.9 26660.2 27147.6 27226.6 26352.6 27162.6 36979.6 37057.0 37772.2 194620.0 195770.0 197595.0 197653.0 198080.0 27101.7 27422.2 27452.5 27478.3 27505.7 35418.6 36053.8 36217.6 36533.3 37041.3 32192.8 32859.7 33569.2 33872.7 34067.7 32907.3 33081.5 33253.0 33359.5 33392.8 32695.7 32936.3 32980.7 33400.5 33406.2 29348.6 29735.3 30704.4 30839.0 30863.4 23618.9 23682.3 23714.5 23849.4 23871.4 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | [#2] jquery.html Cycles:180 Average:26744.43 Median:4534.21 stddev:79514.17 (1753.7%) stddev-sans-first:79712.50 10:35:03 INFO - PROCESS | 5596 | Values: 333.5 334.4 335.1 335.4 335.9 11476.9 11854.3 14776.6 15140.6 15567.6 9421.0 9483.1 9791.2 9792.2 9804.9 4409.8 4528.3 4528.6 4533.4 4535.0 3420.2 3515.3 4457.5 4988.4 5124.4 5082.7 5100.7 5103.4 5122.5 5127.5 5069.7 5092.8 5475.1 5480.9 5485.0 4838.4 4859.7 4881.8 4883.9 4886.2 17760.4 18489.4 18507.2 19157.7 19200.0 1834.1 1871.1 1907.0 1930.3 1942.9 6000.6 6014.1 8554.6 8750.3 9112.8 1619.5 1770.1 1800.4 1804.1 1829.3 52873.0 54407.0 56726.7 57972.4 59435.1 14752.0 14875.6 15820.8 16056.5 16248.4 22574.4 22649.7 22835.1 22847.0 22901.4 7148.5 7213.3 7237.4 7418.2 7890.8 6250.1 6452.4 6458.8 6474.6 6531.2 7603.5 7814.8 7833.5 7838.5 7957.0 1676.7 1708.9 1728.7 2060.8 2931.1 765.9 815.4 838.3 931.3 940.5 14512.3 15097.7 15656.1 15698.1 15995.9 683.9 869.9 882.7 889.8 908.5 8274.3 9040.0 9446.0 9484.8 9674.4 481698.8 483533.0 486251.0 490166.0 492078.0 72449.6 74155.6 75340.6 75464.0 75891.6 918.3 945.3 947.0 956.3 1048.9 13728.5 14246.5 14354.9 14521.9 15015.2 32773.2 33136.7 33737.3 33974.8 34328.7 41879.8 42717.8 42775.4 43115.0 45785.0 8328.5 8496.2 8501.7 8502.1 8551.9 9801.5 16405.4 16715.0 16739.7 16933.6 13685.5 13990.3 14142.2 14175.1 14314.1 13311.8 13392.0 13578.9 13670.4 13899.8 13550.2 13620.7 13706.1 14258.9 14595.9 6633.2 6830.6 8637.2 8881.3 9007.6 13209.6 13239.1 13625.5 13661.9 13689.3 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | [#3] mootools.html Cycles:180 Average:4768.08 Median:6049.45 stddev:2454.60 (40.6%) stddev-sans-first:2445.25 10:35:03 INFO - PROCESS | 5596 | Values: 1013.3 1362.8 1372.8 1473.9 1702.5 5802.3 6503.3 6616.2 6631.0 6638.5 6690.5 6842.7 6876.3 6886.0 6896.5 2011.7 2041.0 2049.7 2050.2 2050.4 2002.6 2029.5 2033.4 2046.8 2047.1 2021.9 2034.3 2056.6 2058.1 2058.8 2005.2 2038.4 2039.6 2041.1 2043.2 2021.9 2054.5 2068.2 2070.0 2072.7 6858.1 6921.5 6931.9 6935.2 6936.2 3882.1 3936.0 3937.2 3953.9 3957.6 2644.0 2657.0 2696.6 2738.3 2760.6 814.4 818.8 825.2 853.8 858.4 9171.4 9178.8 9217.0 9219.5 9223.0 3754.2 3764.4 3790.5 3820.5 3831.0 7789.8 7799.6 7812.4 7822.5 7827.7 4026.6 4032.1 4038.0 4045.0 4052.6 2999.7 3051.1 3466.6 3651.5 3657.6 3350.3 3369.7 3382.2 3407.5 3409.5 1036.2 1043.3 1054.6 1056.9 1078.9 737.0 780.9 932.2 952.0 991.6 5921.1 6037.8 6038.7 6039.8 6059.1 1005.8 1006.0 1007.5 1024.8 1036.3 4873.4 5000.2 5002.9 5009.2 5012.5 7873.1 8117.1 8274.9 8349.0 8356.7 7938.8 7952.6 8000.3 8025.2 8063.8 6259.8 6300.5 6310.9 6312.6 6331.3 6168.4 6289.7 6312.2 6314.6 6322.2 7224.9 7311.9 7370.7 7403.0 7409.7 7408.7 7463.1 7512.9 7529.3 7540.5 6230.5 6267.6 6295.5 6311.5 6337.7 6695.9 6712.1 6740.7 6825.4 6835.1 6395.5 6400.4 6432.1 6440.3 6490.3 5193.2 6070.0 6167.0 6179.1 6333.6 6200.7 6238.3 6247.6 6266.4 6278.7 5712.7 5725.2 5749.8 5750.4 5754.5 5760.6 5795.5 5797.4 5800.0 5800.6 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | [#4] prototype.html Cycles:180 Average:4709.72 Median:5217.98 stddev:1378.37 (26.4%) stddev-sans-first:1341.70 10:35:03 INFO - PROCESS | 5596 | Values: 288.7 296.5 297.8 303.8 305.2 5226.0 5308.2 5407.7 5412.1 5419.2 5208.4 5364.3 5374.5 5379.5 5384.4 4162.8 4206.5 4208.7 4210.2 4212.9 3926.2 4015.8 4084.7 4207.1 4207.5 4161.5 4162.8 4166.0 4170.1 4186.4 4161.3 4172.1 4176.9 4177.1 4182.6 3689.1 3690.5 3691.1 3691.5 3694.5 4646.3 4888.2 5033.5 5203.1 5210.0 4667.3 4686.7 4714.3 4762.0 4809.7 5661.5 5672.2 5684.2 5687.3 5687.9 3714.8 3815.6 3918.0 4031.5 4060.8 5895.7 5960.7 5971.0 5974.0 5991.4 4125.6 4144.6 4148.1 4153.3 4158.1 4178.0 4189.5 4208.4 4211.9 4212.3 4666.7 4781.2 4781.7 4787.5 4791.4 5662.9 5664.4 5666.8 5672.1 5677.5 1464.1 1484.4 1484.9 1486.7 1487.4 1000.0 1008.4 1014.7 1018.7 1027.8 4985.4 4990.7 4995.2 4999.7 5002.1 5896.3 5904.1 5907.3 5911.0 5911.4 4979.7 4991.1 4992.5 4994.3 4994.5 3097.4 3156.1 3174.6 3181.3 3185.4 5564.3 5567.4 5574.9 5579.9 5582.4 6031.1 6044.9 6049.5 6055.1 6055.9 5441.0 5562.1 5570.1 5571.4 5574.4 5875.6 5879.7 5888.3 5893.1 5897.4 5537.0 5671.4 5724.3 5728.0 5738.1 5457.9 5596.2 5596.8 5604.9 5619.8 4147.4 4148.6 4149.6 4151.1 4153.9 5931.7 5933.3 5934.3 5935.5 5935.6 5569.4 5703.9 5713.1 5713.3 5763.2 5670.2 5704.9 5713.7 5715.2 5722.3 5514.1 5519.4 5547.3 5552.9 5557.7 5630.2 5749.1 5751.5 5752.4 5763.4 5577.2 5581.4 5584.4 5585.4 5592.2 10:35:03 INFO - PROCESS | 5596 | 10:35:03 INFO - PROCESS | 5596 | [#5] yui.html Cycles:180 Average:11989.73 Median:26934.60 stddev:14273.56 (53.0%) stddev-sans-first:14288.28 10:35:03 INFO - PROCESS | 5596 | Values: 668.7 679.4 783.1 788.5 819.3 10424.3 10597.9 10614.1 10615.8 10623.9 11576.1 11644.5 11647.5 11678.2 11679.4 476.8 487.1 782.7 787.4 796.0 796.7 796.8 803.0 803.5 803.7 833.2 838.4 839.3 839.7 840.0 457.7 462.3 814.6 828.4 828.7 609.8 612.4 612.8 613.1 616.0 11059.8 11158.0 11175.7 11184.9 11186.8 10345.4 10986.1 11015.2 11115.8 11642.8 9040.6 9631.0 9741.6 9887.5 10024.0 3154.6 3281.7 3289.1 3296.2 3297.2 40558.8 41115.8 41219.0 41815.6 41982.0 8689.6 9011.6 9168.1 9280.4 9332.6 15887.8 15924.4 15929.3 15934.6 15939.5 6162.3 6175.8 6221.5 6245.5 6373.9 3510.5 3546.0 3550.1 3553.8 3608.1 2687.2 2839.2 2922.5 2927.2 2929.8 494.2 503.9 511.2 521.3 532.5 408.5 412.6 426.1 433.8 475.7 6950.5 6971.5 7249.4 7255.4 8134.0 434.6 448.8 487.8 513.1 519.7 3286.7 3299.4 3349.3 3505.5 3521.3 50379.5 53336.7 53397.0 53476.7 53500.5 43773.8 44611.3 44762.6 44838.3 46095.5 40767.2 41932.6 42478.8 42569.0 42599.4 6996.3 7201.3 7295.5 7319.3 7435.0 30794.4 31167.4 31371.2 31387.7 31781.5 37276.4 37915.4 40257.0 40796.4 40870.8 8057.6 8450.4 8616.8 8738.8 9230.2 8804.5 9241.2 9304.0 9727.9 9993.2 8310.9 8351.1 8406.0 8486.0 8575.1 9410.9 9459.1 9490.5 9557.2 9786.8 9201.2 9208.6 9212.5 9264.8 9267.2 7875.5 8010.4 8193.4 8452.7 8568.1 7555.0 7629.4 7689.9 7789.3 7827.5 10:35:03 INFO - PROCESS | 5596 | -------- Summary: end -------- 10:35:03 INFO - PROCESS | 5596 | 10:35:04 INFO - TEST-INFO | 5596: exit 0 10:35:04 INFO - TEST-OK | dromaeo_css | took 1116623ms 10:35:04 INFO - TEST-START | kraken 10:35:04 INFO - operating with platform_type : linux_ 10:35:04 INFO - Initialising browser for kraken test... 10:35:04 INFO - TEST-INFO | started process 5785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgzRiFt/profile http://localhost:32911/getInfo.html) 10:35:08 INFO - PROCESS | 5785 | __metrics Screen width/height:1600/1200 10:35:08 INFO - PROCESS | 5785 | colorDepth:24 10:35:08 INFO - PROCESS | 5785 | Browser inner width/height: 1024/697 10:35:08 INFO - PROCESS | 5785 | __metrics 10:35:08 INFO - PROCESS | 5785 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:35:08 INFO - PROCESS | 5785 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:08 INFO - TEST-INFO | 5785: exit 0 10:35:08 INFO - Browser initialized. 10:35:08 INFO - Running cycle 1/1 for kraken test... 10:35:08 INFO - TEST-INFO | started process 5867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgzRiFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:20 INFO - PROCESS | 5867 | RSS: Main: 149573632 10:35:20 INFO - PROCESS | 5867 | 10:35:23 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32911/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:24 INFO - PROCESS | 5867 | RSS: Main: 186118144 10:35:24 INFO - PROCESS | 5867 | 10:35:26 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32911/tests/kraken/driver.html?testName=audio-dft) 10:35:27 INFO - PROCESS | 5867 | RSS: Main: 177016832 10:35:27 INFO - PROCESS | 5867 | 10:35:30 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32911/tests/kraken/driver.html?testName=audio-fft) 10:35:30 INFO - PROCESS | 5867 | RSS: Main: 159952896 10:35:30 INFO - PROCESS | 5867 | 10:35:33 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32911/tests/kraken/driver.html?testName=audio-oscillator) 10:35:33 INFO - PROCESS | 5867 | RSS: Main: 163676160 10:35:33 INFO - PROCESS | 5867 | 10:35:35 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:36 INFO - PROCESS | 5867 | RSS: Main: 165367808 10:35:36 INFO - PROCESS | 5867 | 10:35:39 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32911/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:40 INFO - PROCESS | 5867 | RSS: Main: 164282368 10:35:40 INFO - PROCESS | 5867 | 10:35:43 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32911/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:44 INFO - PROCESS | 5867 | RSS: Main: 165691392 10:35:44 INFO - PROCESS | 5867 | 10:35:46 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32911/tests/kraken/driver.html?testName=json-parse-financial) 10:35:47 INFO - PROCESS | 5867 | RSS: Main: 165404672 10:35:47 INFO - PROCESS | 5867 | 10:35:49 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:49 INFO - PROCESS | 5867 | RSS: Main: 175812608 10:35:49 INFO - PROCESS | 5867 | 10:35:51 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:52 INFO - PROCESS | 5867 | RSS: Main: 174723072 10:35:52 INFO - PROCESS | 5867 | 10:35:54 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:54 INFO - PROCESS | 5867 | RSS: Main: 189120512 10:35:54 INFO - PROCESS | 5867 | 10:35:57 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:58 INFO - PROCESS | 5867 | RSS: Main: 190869504 10:35:58 INFO - PROCESS | 5867 | 10:36:00 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:01 INFO - PROCESS | 5867 | RSS: Main: 190046208 10:36:01 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | Cycle 1(1): loaded http://localhost:32911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32911/tests/kraken/driver.html?testName=ai-astar) 10:36:03 INFO - PROCESS | 5867 | RSS: Main: 248107008 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | __start_tp_report 10:36:03 INFO - PROCESS | 5867 | _x_x_mozilla_page_load 10:36:03 INFO - PROCESS | 5867 | _x_x_mozilla_page_load_details 10:36:03 INFO - PROCESS | 5867 | |i|pagename|runs| 10:36:03 INFO - PROCESS | 5867 | |0;ai-astar;113;113;107;112;113;112;104;112;112;101 10:36:03 INFO - PROCESS | 5867 | |1;audio-beat-detection;153;132;156;171;132;153;161;133;171;131 10:36:03 INFO - PROCESS | 5867 | |2;audio-dft;178;161;161;160;163;161;161;161;163;163 10:36:03 INFO - PROCESS | 5867 | |3;audio-fft;72;72;83;92;72;73;71;105;94;75 10:36:03 INFO - PROCESS | 5867 | |4;audio-oscillator;96;99;144;97;97;98;139;98;99;133 10:36:03 INFO - PROCESS | 5867 | |5;imaging-gaussian-blur;110;109;109;110;109;109;111;110;110;109 10:36:03 INFO - PROCESS | 5867 | |6;imaging-darkroom;147;147;146;147;146;147;146;146;147;147 10:36:03 INFO - PROCESS | 5867 | |7;imaging-desaturate;96;96;95;96;95;95;97;96;95;95 10:36:03 INFO - PROCESS | 5867 | |8;json-parse-financial;71;72;72;71;71;70;71;79;68;71 10:36:03 INFO - PROCESS | 5867 | |9;json-stringify-tinderbox;67;67;67;68;67;68;67;68;69;68 10:36:03 INFO - PROCESS | 5867 | |10;stanford-crypto-aes;84;86;86;87;85;84;85;84;88;86 10:36:03 INFO - PROCESS | 5867 | |11;stanford-crypto-ccm;138;123;128;119;131;123;134;118;119;134 10:36:03 INFO - PROCESS | 5867 | |12;stanford-crypto-pbkdf2;155;137;152;149;150;157;148;148;155;137 10:36:03 INFO - PROCESS | 5867 | |13;stanford-crypto-sha256-iterative;70;71;77;69;71;72;69;69;70;70 10:36:03 INFO - PROCESS | 5867 | __end_tp_report 10:36:03 INFO - PROCESS | 5867 | __start_cc_report 10:36:03 INFO - PROCESS | 5867 | _x_x_mozilla_cycle_collect,968 10:36:03 INFO - PROCESS | 5867 | __end_cc_report 10:36:03 INFO - PROCESS | 5867 | __startTimestamp1451500563383__endTimestamp 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | ------- Summary: start ------- 10:36:03 INFO - PROCESS | 5867 | Number of tests: 14 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:4.33 (3.9%) stddev-sans-first:4.45 10:36:03 INFO - PROCESS | 5867 | Values: 113.0 113.0 107.0 112.0 113.0 112.0 104.0 112.0 112.0 101.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:154.50 stddev:16.16 (10.5%) stddev-sans-first:17.08 10:36:03 INFO - PROCESS | 5867 | Values: 153.0 132.0 156.0 171.0 132.0 153.0 161.0 133.0 171.0 131.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.00 stddev:5.31 (3.3%) stddev-sans-first:1.13 10:36:03 INFO - PROCESS | 5867 | Values: 178.0 161.0 161.0 160.0 163.0 161.0 161.0 161.0 163.0 163.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.00 stddev:12.08 (16.3%) stddev-sans-first:12.37 10:36:03 INFO - PROCESS | 5867 | Values: 72.0 72.0 83.0 92.0 72.0 73.0 71.0 105.0 94.0 75.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:97.50 stddev:19.97 (20.5%) stddev-sans-first:20.53 10:36:03 INFO - PROCESS | 5867 | Values: 96.0 99.0 144.0 97.0 97.0 98.0 139.0 98.0 99.0 133.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 10:36:03 INFO - PROCESS | 5867 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 111.0 110.0 110.0 109.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:36:03 INFO - PROCESS | 5867 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 10:36:03 INFO - PROCESS | 5867 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 97.0 96.0 95.0 95.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.00 stddev:2.84 (4.0%) stddev-sans-first:3.00 10:36:03 INFO - PROCESS | 5867 | Values: 71.0 72.0 72.0 71.0 71.0 70.0 71.0 79.0 68.0 71.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 10:36:03 INFO - PROCESS | 5867 | Values: 67.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 69.0 68.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.32 10:36:03 INFO - PROCESS | 5867 | Values: 84.0 86.0 86.0 87.0 85.0 84.0 85.0 84.0 88.0 86.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:129.50 stddev:7.27 (5.6%) stddev-sans-first:6.46 10:36:03 INFO - PROCESS | 5867 | Values: 138.0 123.0 128.0 119.0 131.0 123.0 134.0 118.0 119.0 134.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:151.00 stddev:6.96 (4.6%) stddev-sans-first:7.01 10:36:03 INFO - PROCESS | 5867 | Values: 155.0 137.0 152.0 149.0 150.0 157.0 148.0 148.0 155.0 137.0 10:36:03 INFO - PROCESS | 5867 | 10:36:03 INFO - PROCESS | 5867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:70.50 stddev:2.39 (3.4%) stddev-sans-first:2.52 10:36:03 INFO - PROCESS | 5867 | Values: 70.0 71.0 77.0 69.0 71.0 72.0 69.0 69.0 70.0 70.0 10:36:03 INFO - PROCESS | 5867 | -------- Summary: end -------- 10:36:03 INFO - PROCESS | 5867 | 10:36:04 INFO - TEST-INFO | 5867: exit 0 10:36:04 INFO - TEST-OK | kraken | took 60228ms 10:36:04 INFO - TEST-START | v8_7 10:36:04 INFO - operating with platform_type : linux_ 10:36:04 INFO - Initialising browser for v8_7 test... 10:36:04 INFO - TEST-INFO | started process 6117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtslbo/profile http://localhost:32911/getInfo.html) 10:36:08 INFO - PROCESS | 6117 | __metrics Screen width/height:1600/1200 10:36:08 INFO - PROCESS | 6117 | colorDepth:24 10:36:08 INFO - PROCESS | 6117 | Browser inner width/height: 1024/697 10:36:08 INFO - PROCESS | 6117 | __metrics 10:36:08 INFO - PROCESS | 6117 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:36:08 INFO - PROCESS | 6117 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:36:09 INFO - TEST-INFO | 6117: exit 0 10:36:09 INFO - Browser initialized. 10:36:09 INFO - Running cycle 1/1 for v8_7 test... 10:36:09 INFO - TEST-INFO | started process 6202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtslbo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:21 INFO - PROCESS | 6202 | RSS: Main: 150171648 10:36:21 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | Cycle 1(1): loaded http://localhost:32911/tests/v8_7/run.html (next: http://localhost:32911/tests/v8_7/run.html) 10:36:42 INFO - PROCESS | 6202 | RSS: Main: 449736704 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | __start_tp_report 10:36:42 INFO - PROCESS | 6202 | _x_x_mozilla_page_load 10:36:42 INFO - PROCESS | 6202 | _x_x_mozilla_page_load_details 10:36:42 INFO - PROCESS | 6202 | |i|pagename|runs| 10:36:42 INFO - PROCESS | 6202 | |0;Richards;166.77785190126752 10:36:42 INFO - PROCESS | 6202 | |1;DeltaBlue;188.78610534264678 10:36:42 INFO - PROCESS | 6202 | |2;Encrypt;278.08676307007784 10:36:42 INFO - PROCESS | 6202 | |3;Decrypt;5240.837696335078 10:36:42 INFO - PROCESS | 6202 | |4;RayTrace;2002 10:36:42 INFO - PROCESS | 6202 | |5;Earley;802.0833333333334 10:36:42 INFO - PROCESS | 6202 | |6;Boyer;11928.57142857143 10:36:42 INFO - PROCESS | 6202 | |7;RegExp;28500 10:36:42 INFO - PROCESS | 6202 | |8;Splay;620.7324643078833 10:36:42 INFO - PROCESS | 6202 | |9;NavierStokes;4850.241545893719 10:36:42 INFO - PROCESS | 6202 | __end_tp_report 10:36:42 INFO - PROCESS | 6202 | __startTimestamp1451500602838__endTimestamp 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | ------- Summary: start ------- 10:36:42 INFO - PROCESS | 6202 | Number of tests: 10 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 166.8 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 188.8 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 278.1 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 5240.8 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 2002.0 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#5] Earley Cycles:1 Average:802.08 Median:802.08 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 802.1 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#6] Boyer Cycles:1 Average:11928.57 Median:11928.57 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 11928.6 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#7] RegExp Cycles:1 Average:28500.00 Median:28500.00 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 28500.0 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#8] Splay Cycles:1 Average:620.73 Median:620.73 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 620.7 10:36:42 INFO - PROCESS | 6202 | 10:36:42 INFO - PROCESS | 6202 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 10:36:42 INFO - PROCESS | 6202 | Values: 4850.2 10:36:42 INFO - PROCESS | 6202 | -------- Summary: end -------- 10:36:42 INFO - PROCESS | 6202 | 10:36:43 INFO - TEST-INFO | 6202: exit 0 10:36:43 INFO - TEST-OK | v8_7 | took 39526ms 10:36:43 INFO - SUITE-END | took 1216s 10:36:44 INFO - Completed test suite (00:20:16) 10:36:44 INFO - Working with test: dromaeo_css 10:36:44 INFO - Generating results file: dromaeo_css 10:36:44 INFO - Working with test: kraken 10:36:44 INFO - Generating results file: kraken 10:36:44 INFO - javascript benchmark 10:36:44 INFO - Working with test: v8_7 10:36:44 INFO - Generating results file: v8_7 10:36:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:36:44 INFO - process_Request line: dromaeo_css 6210.84 graph.html#tests=[[72,132,35]] 10:36:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:44 INFO - process_Request line: kraken 1536.10 graph.html#tests=[[232,132,35]] 10:36:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:44 INFO - process_Request line: v8_7 19576.73 graph.html#tests=[[230,132,35]] 10:36:44 INFO - RETURN: dromaeo_css: 6210.84 10:36:44 INFO - RETURN: kraken: 1536.10 10:36:44 INFO - RETURN: v8_7: 19576.73 10:36:44 INFO - javascript benchmark 10:36:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2592.805539584531, 2683.3157544826067, 2686.7850571954245, 2691.380982374054, 2713.0233116078207, 4456.732596044231, 4544.068465964478, 4602.19461594221, 4621.260598304272, 4630.4906460289385, 4621.12198682251, 4628.1669299526075, 4630.722156670602, 4750.9049819003685, 4764.880877978052, 4257.14857028594, 4329.480462344507, 4332.371806088116, 4353.695241333108, 4416.80124394403, 4215.473065866767, 4266.7866606669695, 4330.004099057219, 4346.391505189276, 4347.500037495681, 4157.875263742093, 4260.680448966309, 4299.441072660534, 4347.84782532613, 4358.0412309291905, 4266.338717498793, 4349.956500434987, 4354.150940566591, 4356.542563030868, 4378.277584198603, 4263.019505513718, 4279.443672322609, 4285.164392943378, 4293.849715259982, 4322.0491491871735, 4376.212281789277, 4467.843625473125, 4485.035717320791, 4592.954070459286, 4626.444826620794, 4956.479569645171, 5012.0, 5042.899142017176, 5072.036313100499, 5074.695518268879, 5057.165567681328, 5062.594992400599, 5065.873353166164, 5117.692938423706, 5117.872053198663, 4459.910801783946, 4556.521565235669, 4696.060787842445, 4704.717716936994, 4707.7175369477945, 4968.90062198754, 5031.748412579356, 5094.566961808214, 5138.3577052868395, 5142.331496905378, 4863.927041094386, 4871.342368780241, 4872.9512704872495, 4873.049755297754, 4911.091448082045, 4747.359106520645, 4853.927191092136, 4956.801727930842, 4965.652404331734, 4979.6265280104135, 4813.95186048142, 4908.04293162837, 4981.975090124526, 5002.274670172877, 5038.067957427887, 4930.975345123252, 4940.777665005084, 4947.208446648519, 4950.886050638577, 4993.101241776442, 3931.095847954929, 4036.8183431745642, 4161.3549899765585, 4170.061736109412, 4208.137331846964, 3582.7671201371827, 3595.7123430125525, 3642.508261384732, 3670.7981061041364, 3687.022938921188, 4250.787460626956, 4288.935665965013, 4290.056187638715, 4290.528041915387, 4321.5678432157165, 4731.574158325699, 4836.274558816135, 4927.260910863328, 4954.157793175169, 5005.824796132118, 4135.937960930589, 4241.915161696748, 4316.805743741539, 4325.070109926318, 4350.58669426404, 4411.338299255138, 4414.646828253732, 4416.80124394403, 4421.690481666253, 4448.0, 4553.2259515881715, 4658.930116048195, 4716.952830471651, 4720.811167553259, 4723.480417154179, 4855.757212139309, 4937.703737775745, 5038.47096054909, 5050.292958985671, 5061.9493805061475, 4717.363155974037, 4725.645576581839, 4730.219513780187, 4730.266808644666, 4772.7136371817805, 4895.118878601886, 4915.877103072452, 4918.262260660929, 4920.532549407801, 4949.109160351028, 4807.879803004813, 4915.729634870117, 4926.310316555613, 4933.703977761345, 5073.6955782651685, 4814.374131362901, 4825.565699087099, 4831.492693267156, 4832.371791667061, 4864.829730959399, 4793.13723529754, 4794.041191761731, 4798.712077275374, 4800.831970881002, 4838.371011768589, 4495.977520112378, 4608.239640459286, 4608.423947006624, 4609.032103258353, 4681.531846815291, 4854.344663470528, 4858.222684370625, 4859.1010663027455, 4894.657373983787, 4899.069176856386, 4729.243321068612, 4733.573978341966, 4738.194506933898, 4745.169595320736, 4783.760811959458], "unit": "score", "name": "dojo.html", "value": 4552.800452065822}, {"lowerIsBetter": false, "replicates": [455.1715877103671, 461.709123252351, 487.6854428893364, 502.3946144895401, 535.7214248590733, 20813.583728325444, 32301.192470188256, 33025.66974330262, 33117.83441082791, 33199.33601327972, 36712.81643591785, 36863.0, 37090.814545927235, 37220.06949826256, 37223.255534889286, 6577.651581425796, 6675.399214070732, 7598.278163574465, 7757.0, 7765.728199513018, 9654.420734755937, 9858.753531161743, 9872.45701486418, 9885.308028438012, 9890.357126786736, 9619.374740641872, 9714.36856604322, 9722.756931076745, 9728.0, 9732.10224006319, 6789.355011273897, 6917.619530925797, 9574.377665451793, 9636.084571965652, 9779.706608801676, 9329.253659707207, 9457.527123643791, 9458.763530911714, 9486.90513094874, 9490.810183796355, 32761.0, 33241.0, 33251.6674833251, 33328.6667133328, 33493.0, 2764.2951047482966, 2967.940641187186, 3050.496668049769, 3487.860485580574, 3528.0, 25309.0, 26700.73299267002, 26720.0, 26721.331966700793, 27416.177514674593, 3477.6522347765276, 3526.347625689256, 3547.929041419183, 3604.4953706481115, 3613.3495970725257, 222507.0, 223808.0, 224985.0, 225118.0, 225457.0, 35142.64857351445, 35762.0, 54987.72506137444, 55306.446935530126, 55841.7207913966, 49276.50723492791, 49511.25733114006, 49542.0, 49566.25650615244, 49778.0, 11446.313221206754, 11653.41732913351, 11687.357195354167, 11715.062794976382, 11728.472218750177, 8921.375503714808, 9004.50475223856, 9009.324300677476, 9013.819723605491, 9014.774630634156, 18860.434186974413, 18988.620227595646, 19055.237790488503, 19138.23447062102, 19150.882560249614, 7378.40972722181, 7683.231676832272, 7897.328727058264, 7941.761747147595, 8027.237412445808, 827.755812035451, 829.6930135849774, 878.2403221213605, 942.7218970403748, 1031.2729525684374, 26137.215883523524, 26165.345866353113, 26470.0, 26675.0, 27635.170944871687, 915.5102020419178, 916.5783739479914, 983.9655612053543, 994.4629899853998, 1022.5551884930079, 14618.780718289234, 15460.149691766836, 16099.67800644004, 16219.51341459758, 16224.107674077803, 335871.0, 339837.0, 341778.0, 341787.0, 342144.0, 33009.83495082509, 46770.766146169735, 47171.0, 47181.76409117933, 47270.76364618224, 957.3777044920857, 1178.7171078941165, 1216.239850093709, 1219.3293688471306, 1223.0460241012024, 26270.0, 26413.867930660224, 26660.200193994213, 27147.59278610862, 27226.591601126394, 26352.60471092897, 27162.592561111993, 36979.63020369762, 37057.0, 37772.24455510819, 194620.0, 195770.0, 197595.0, 197653.0, 198080.0, 27101.72898270992, 27422.177334679993, 27452.45095098047, 27478.313042173308, 27505.724942750316, 35418.64581354154, 36053.81973090223, 36217.63782362143, 36533.269334612625, 37041.25917481689, 32192.83903580467, 32859.67140328566, 33569.16077098092, 33872.66127338695, 34067.65932340645, 32907.341853163285, 33081.50377744384, 33253.0, 33359.49960750542, 33392.833035834665, 32695.673043269264, 32936.34127317488, 32980.67019329872, 33400.49899251562, 33406.164845879044, 29348.559771603017, 29735.256618583844, 30704.385912282076, 30839.0, 30863.382732345675, 23618.881905590362, 23682.289531314087, 23714.52570948537, 23849.403764906016, 23871.40321491907], "unit": "score", "name": "ext.html", "value": 16535.171424091535}, {"lowerIsBetter": false, "replicates": [333.4631243697646, 334.43313583476004, 335.1437078265033, 335.3862431749898, 335.85893924551686, 11476.942615286933, 11854.3480108594, 14776.6305842354, 15140.621484462894, 15567.610809729762, 9421.0, 9483.099105584975, 9791.167750741177, 9792.16766574842, 9804.901950980488, 4409.757463339515, 4528.252838281696, 4528.615067719248, 4533.387992620987, 4535.024969631545, 3420.2133509292876, 3515.2617950230356, 4457.48738895028, 4988.401391832967, 5124.385073791151, 5082.745862706868, 5100.719460429675, 5103.3875934887865, 5122.513361230677, 5127.461616530267, 5069.74651267437, 5092.79628814847, 5475.0966090595, 5480.862978425532, 5484.972575137099, 4838.419389673261, 4859.71217627329, 4881.780319885614, 4883.853484395474, 4886.193778026622, 17760.3783867564, 18489.352872649393, 18507.167177477048, 19157.712634310497, 19200.0, 1834.0737927346738, 1871.073818459871, 1907.0464767616193, 1930.2664987304875, 1942.8931408772512, 6000.579959402844, 6014.097885317194, 8554.572271386469, 8750.299976001905, 9112.817743645157, 1619.4817658349332, 1770.1414813815288, 1800.3518733256017, 1804.1159831682512, 1829.2957211473679, 52873.0, 54407.0, 56726.71636641832, 57972.42027579712, 59435.108473373366, 14751.967362284537, 14875.628109297139, 15820.841791581937, 16056.518304450885, 16248.350065997227, 22574.435639109153, 22649.660255096187, 22835.086596536286, 22847.0, 22901.427464313194, 7148.535345202546, 7213.278672132849, 7237.384822290059, 7418.1825452764415, 7890.842183156305, 6250.124982502453, 6452.419282264619, 6458.838529036811, 6474.611523308617, 6531.216254049449, 7603.467757256939, 7814.843703125905, 7833.529988200727, 7838.451308408356, 7957.045154581488, 1676.6814305281957, 1708.871834612409, 1728.6801941640836, 2060.8047332547085, 2931.120663800851, 765.8659734546543, 815.3640160674684, 838.3167718309559, 931.29221791439, 940.5062342270363, 14512.274386280644, 15097.698046039017, 15656.138912359702, 15698.136602486973, 15995.920020399824, 683.9247682754893, 869.8738682890945, 882.7263548300048, 889.8309321228945, 908.5003248213457, 8274.255317021498, 9039.954800225956, 9445.952770236105, 9484.810303794024, 9674.371165874196, 481698.7745183825, 483533.0, 486251.0, 490166.0, 492078.0, 72449.63775181091, 74155.62922185354, 75340.62329688316, 75464.0, 75891.62054189693, 918.3020904112789, 945.2863088368375, 946.976325591852, 956.3066776587058, 1048.8688913885917, 13728.45086196541, 14246.501372451914, 14354.928225359225, 14521.86357765811, 15015.249237538297, 32773.18067048248, 33136.66863331432, 33737.3252534943, 33974.830125849214, 34328.656713432545, 41879.7906010468, 42717.78641106775, 42775.3583696251, 43115.0, 45785.0, 8328.500289982621, 8496.150384961455, 8501.702440414803, 8502.107278735644, 8551.871721924052, 9801.46165641121, 16405.42581009659, 16715.0, 16739.66520669604, 16933.57666058309, 13685.521006764715, 13990.300484975507, 14142.22217778032, 14175.149491030572, 14314.069585476911, 13311.800322995357, 13392.0, 13578.86421135776, 13670.436284148705, 13899.791503127259, 13550.186988780704, 13620.709476514867, 13706.109102908278, 14258.857411425754, 14595.92702036483, 6633.237177724431, 6830.556013859084, 8637.179467950535, 8881.333899957399, 9007.594658240527, 13209.603711888658, 13239.139455935334, 13625.523106691218, 13661.86338136606, 13689.31553422305], "unit": "score", "name": "jquery.html", "value": 8447.510061053252}, {"lowerIsBetter": false, "replicates": [1013.3261381181514, 1362.781954887218, 1372.807806907033, 1473.9410423583058, 1702.5403141151883, 5802.332731735852, 6503.284638689746, 6616.206055273368, 6630.96684516578, 6638.50211234157, 6690.498212634047, 6842.692078856451, 6876.312368763121, 6885.965570172155, 6896.517243792937, 2011.7083022961626, 2040.9795902041012, 2049.6515592349338, 2050.241410678051, 2050.425880753384, 2002.5894691588262, 2029.502771820906, 2033.4103110098129, 2046.774854765982, 2047.119738512439, 2021.858469907107, 2034.2676636410881, 2056.578401427711, 2058.1047244448637, 2058.7632422271404, 2005.1578337098454, 2038.4190505705876, 2039.6430624640777, 2041.101915157326, 2043.2031507712004, 2021.858469907107, 2054.4658388819016, 2068.2244158440585, 2069.98965005174, 2072.7305450291515, 6858.074159988388, 6921.48088893335, 6931.896021559681, 6935.237123916365, 6936.167659880796, 3882.145927895858, 3936.0356712605308, 3937.2125574885135, 3953.920921581552, 3957.584453632356, 2643.973560264392, 2657.0, 2696.6359541461848, 2738.2606696191915, 2760.6135141080063, 814.4339683919678, 818.7789296889866, 825.22428916818, 853.8249658819989, 858.3648100405717, 9171.358004939657, 9178.81642367149, 9217.0, 9219.492927888963, 9223.0, 3754.249150169977, 3764.416515440111, 3790.4882840816135, 3820.5033345665443, 3830.961690383116, 7789.766307010798, 7799.610019499002, 7812.375009999187, 7822.452428330076, 7827.726029589051, 4026.57720939303, 4032.0927791246736, 4038.030872590557, 4045.0, 4052.594740525924, 2999.6700362960055, 3051.06942382571, 3466.6360032196762, 3651.470536772153, 3657.6342365763744, 3350.3131857969056, 3369.663033696611, 3382.1713680148027, 3407.522946787452, 3409.5226668266464, 1036.2435422141878, 1043.2697112021615, 1054.583439541377, 1056.8731752189785, 1078.8813230544633, 736.9520981136209, 780.9414293927978, 932.1936524905908, 951.9809603807885, 991.6380521109743, 5921.141434491975, 6037.849053773603, 6038.728257228435, 6039.818805435844, 6059.091136329585, 1005.8139244239838, 1005.9547320370601, 1007.4861820471613, 1024.8206563851297, 1036.3471013261596, 4873.439554451284, 5000.199968005102, 5002.949970500248, 5009.248612708123, 5012.523810238022, 7873.094594121635, 8117.107118216992, 8274.875876861852, 8349.03986041601, 8356.749297521084, 7938.841223175504, 7952.642131104114, 8000.279974802295, 8025.197480251928, 8063.838723225503, 6259.78090766821, 6300.527460440485, 6310.9368906311265, 6312.6212427253595, 6331.271903731038, 6168.383161683975, 6289.685515724287, 6312.210973628296, 6314.55798094129, 6322.178116844781, 7224.855502890018, 7311.853762924606, 7370.705171793283, 7402.962985185255, 7409.703611855681, 7408.6666100026705, 7463.104427468521, 7512.887306690294, 7529.3223609873185, 7540.509866858637, 6230.470410015199, 6267.561270711007, 6295.496360291074, 6311.463525600376, 6337.683115844282, 6695.899561506679, 6712.127423434922, 6740.730370785113, 6825.419839313714, 6835.077264569419, 6395.5203359747275, 6400.39196276353, 6432.099506069248, 6440.32376600469, 6490.286068532552, 5193.195054766517, 6069.969650151721, 6166.969165154145, 6179.134921110958, 6333.556651034383, 6200.720967556381, 6238.313785483502, 6247.625142491465, 6266.436020758154, 6278.717457714505, 5712.65724056558, 5725.169850371756, 5749.770009199585, 5750.367459579526, 5754.4533269339345, 5760.6255593386295, 5795.5073818724195, 5797.449242321973, 5800.042992906292, 5800.622959507618], "unit": "score", "name": "mootools.html", "value": 3919.9615418287635}, {"lowerIsBetter": false, "replicates": [288.6896586169867, 296.50631698222463, 297.77369199408446, 303.76154718545934, 305.16689437834725, 5225.973870130653, 5308.150695888658, 5407.702576358303, 5412.134058550628, 5419.160030195316, 5208.401033881105, 5364.275822763926, 5374.543163831069, 5379.462053794618, 5384.40771515134, 4162.750234985903, 4206.47419072616, 4208.705390622657, 4210.242156411845, 4212.915741685165, 3926.175503144329, 4015.759054456742, 4084.7344922580087, 4207.095474472988, 4207.537170911197, 4161.500619925598, 4162.83348666053, 4165.979170104145, 4170.061736109366, 4186.434831297782, 4161.271777438967, 4172.061286210609, 4176.895577610554, 4177.060161463677, 4182.581741825808, 3689.1330537323706, 3690.5202323698018, 3691.077230692327, 3691.50164727761, 3694.4827724118645, 4646.3495110684535, 4888.193448081098, 5033.546980771712, 5203.115470370046, 5209.984053109645, 4667.253239481666, 4686.695364801311, 4714.316424118484, 4762.047590481918, 4809.701380627246, 5661.490465858052, 5672.205891175238, 5684.204211410406, 5687.317521897398, 5687.886242275173, 3714.758540694846, 3815.5993620669706, 3917.98041009796, 4031.5363733170766, 4060.776657283848, 5895.705214739289, 5960.7019649017375, 5970.9701451492465, 5973.970130149365, 5991.370906054845, 4125.628693417607, 4144.564820693844, 4148.108156746253, 4153.314703074019, 4158.147579746144, 4177.958220417818, 4189.49726032878, 4208.410822484854, 4211.915761684749, 4212.283911735012, 4666.65000124992, 4781.187198176249, 4781.665283430196, 4787.54518320759, 4791.377120974251, 5662.886742265132, 5664.405237450091, 5666.829995100154, 5672.14917762339, 5677.489025987681, 1464.0703153497607, 1484.3765618440282, 1484.8515148485064, 1486.6580686442178, 1487.4273404739038, 1000.0, 1008.4403156248353, 1014.6905193915779, 1018.709667744704, 1027.7790275090892, 4985.376827896513, 4990.6506544541535, 4995.175795993693, 4999.65002449825, 5002.09962206799, 5896.292444906639, 5904.114382842608, 5907.2911250650195, 5911.0, 5911.438413350725, 4979.70527662803, 4991.101601711727, 4992.500749924979, 4994.32576602154, 4994.475580064113, 3097.4424603571124, 3156.1162874395204, 3174.619045714483, 3181.3319202967173, 3185.4106990206888, 5564.276644036249, 5567.359753628303, 5574.888502229933, 5579.9163012554845, 5582.385937546866, 6031.125486804389, 6044.9395506044375, 6049.485793707584, 6055.091736239511, 6055.939440605625, 5440.972795135999, 5562.110062389998, 5570.136628822539, 5571.4428557143965, 5574.414686457944, 5875.6474611523445, 5879.7060146993335, 5888.263967004124, 5893.086571581412, 5897.3807750185615, 5537.0, 5671.404502527175, 5724.284464441945, 5728.0, 5738.053221218619, 5457.863553411196, 5596.216529685928, 5596.804111856066, 5604.85987850307, 5619.831405057855, 4147.419361289361, 4148.605882441163, 4149.585041495826, 4151.086760912594, 4153.8961525962095, 5931.733072011683, 5933.317668468008, 5934.347221805511, 5935.465808077293, 5935.554833387427, 5569.443055694398, 5703.889560862342, 5713.057345538106, 5713.314402271754, 5763.193152958673, 5670.206171135962, 5704.914426283692, 5713.742881570256, 5715.17130016137, 5722.341930678025, 5514.117741161395, 5519.448055194448, 5547.306586676666, 5552.888942221214, 5557.666540007613, 5630.211770352236, 5749.137629355463, 5751.482366587027, 5752.424757524214, 5763.394843541368, 5577.191307260506, 5581.413951535031, 5584.357798853184, 5585.357683866245, 5592.217089607377], "unit": "score", "name": "prototype.html", "value": 4265.700325302627}, {"lowerIsBetter": false, "replicates": [668.7427636044237, 679.3546131175383, 783.1189911349732, 788.5465857132143, 819.287220118497, 10424.270301078917, 10597.947010264937, 10614.097801686856, 10615.78768424631, 10623.893761062387, 11576.131790115733, 11644.534218631266, 11647.534098636044, 11678.240914340584, 11679.357635330054, 476.81404252341616, 487.0745583391549, 782.6517199846071, 787.4133770341103, 795.9880601790978, 796.6813274690112, 796.8366484870587, 803.0082847683107, 803.5299349880327, 803.6504120707511, 833.1793183714067, 838.3795990966671, 839.2530647723531, 839.6557411461303, 840.0255703384075, 457.7185031205801, 462.3296220480317, 814.6089876859081, 828.3994104274414, 828.7016673997356, 609.7591451376726, 612.3967891626744, 612.7518355066161, 613.0834402568145, 615.9928516874942, 11059.834102488468, 11158.0, 11175.664730058112, 11184.888151118466, 11186.832197517044, 10345.379277243313, 10986.121110311156, 11015.173861960306, 11115.83326250107, 11642.76714465706, 9040.593173307218, 9630.951845240728, 9741.610335586569, 9887.456189909552, 10024.0, 3154.5899033125775, 3281.6554261802644, 3289.1448223461834, 3296.1924328539662, 3297.1757060734817, 40558.797206014075, 41115.794421028004, 41219.0, 41815.58184418147, 41982.0, 8689.608967596474, 9011.63953441868, 9168.10349123445, 9280.350375473787, 9332.58003389849, 15887.841121588868, 15924.363025478851, 15929.283182256826, 15934.601634958986, 15939.521814345588, 6162.291336496361, 6175.752969881244, 6221.5333849961435, 6245.500359971192, 6373.872522549523, 3510.543629328222, 3546.0, 3550.0592343029116, 3553.7690050146657, 3608.0619039050034, 2687.2207059952784, 2839.176638774732, 2922.503174460347, 2927.1803894909035, 2929.7802664800224, 494.24627443149484, 503.87655024518494, 511.2357026245712, 521.2962500624127, 532.4648728028307, 408.5159086482528, 412.57710846382696, 426.098801035807, 433.82646941223766, 475.7430987266906, 6950.478714096463, 6971.51199416036, 7249.420046396275, 7255.383292420098, 8133.959330203311, 434.63707803983397, 448.81598544596557, 487.84145152825477, 513.125121667556, 519.7297405349273, 3286.7041966223155, 3299.389612921569, 3349.34687735894, 3505.4566542186003, 3521.3485505181625, 50379.49620503822, 53336.73331633394, 53397.0, 53476.73261633667, 53500.464995350325, 43773.78113109478, 44611.33083003757, 44762.55237447584, 44838.32742508865, 46095.539044609795, 40767.18465630671, 41932.58067419348, 42478.78760606177, 42569.0, 42599.36100958488, 6996.335348141918, 7201.3158749918675, 7295.52579082358, 7319.304666056716, 7434.962825185839, 30794.384112318075, 31167.376652467276, 31371.215719607193, 31387.68612313939, 31781.523277151322, 37276.440853387765, 37915.43126853044, 40257.0, 40796.388054179806, 40870.79564602277, 8057.556834374166, 8450.39442505922, 8616.827663446822, 8738.781530461789, 9230.215431688383, 8804.515751633722, 9241.168294853496, 9303.953480232556, 9727.85408218863, 9993.150582200304, 8310.916890831015, 8351.081381048201, 8405.95797021011, 8486.0, 8575.056743758058, 9410.858837117312, 9459.148676619137, 9490.478023708487, 9557.187639050759, 9786.804263914824, 9201.217896478607, 9208.585613647268, 9212.49331286759, 9264.768380790265, 9267.165955064076, 7875.488093273919, 8010.359171266401, 8193.385496087936, 8452.661893524437, 8568.057513673615, 7555.0, 7629.427792915442, 7689.92310076892, 7789.337906277803, 7827.491213071132], "unit": "score", "name": "yui.html", "value": 5397.165352731306}], "name": "dromaeo_css", "value": 6210.83625368468}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 107.0, 112.0, 113.0, 112.0, 104.0, 112.0, 112.0, 101.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 156.0, 171.0, 132.0, 153.0, 161.0, 133.0, 171.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [178.0, 161.0, 161.0, 160.0, 163.0, 161.0, 161.0, 161.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 92.0, 72.0, 73.0, 71.0, 105.0, 94.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 144.0, 97.0, 97.0, 98.0, 139.0, 98.0, 99.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 71.0, 71.0, 70.0, 71.0, 79.0, 68.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 86.0, 87.0, 85.0, 84.0, 85.0, 84.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [138.0, 123.0, 128.0, 119.0, 131.0, 123.0, 134.0, 118.0, 119.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [155.0, 137.0, 152.0, 149.0, 150.0, 157.0, 148.0, 148.0, 155.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 77.0, 69.0, 71.0, 72.0, 69.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1536.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [802.0833333333334], "unit": "score", "name": "Earley", "value": 830.9149090909091}, {"lowerIsBetter": false, "replicates": [11928.57142857143], "unit": "score", "name": "Boyer", "value": 55.871149700598814}, {"lowerIsBetter": false, "replicates": [28500.0], "unit": "score", "name": "RegExp", "value": 31.964385964912278}, {"lowerIsBetter": false, "replicates": [620.7324643078833], "unit": "score", "name": "Splay", "value": 131.28200099999995}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19576.7286629451}]} 10:36:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19576.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1536.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6210.84"}}} 10:36:44 INFO - Return code: 0 10:36:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:36:44 INFO - # TBPL SUCCESS # 10:36:44 INFO - Running post-action listener: _resource_record_post_action 10:36:44 INFO - Running post-run listener: _resource_record_post_run 10:36:45 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 547725312; Read time: 0; Write time: 399288 10:36:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228605952; Read time: 0; Write time: 224736 10:36:45 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 319119360; Read time: 0; Write time: 174552 10:36:45 INFO - Running post-run listener: _upload_blobber_files 10:36:45 INFO - Blob upload gear active. 10:36:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:45 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 10:36:45 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'] 10:36:45 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 10:36:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:47 INFO - (blobuploader) - INFO - Done attempting. 10:36:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:47 INFO - (blobuploader) - INFO - Done attempting. 10:36:47 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:47 INFO - Return code: 0 10:36:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2126d06bb6810fbe0fab00e2d2ecf595e322a6f70892d15ae5d9bef61ac33ed7355a20dde896d570ba2bf452e6bc428037e8f83c823cfdf28831f2a0fcdc8c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33a3391f6858027fa5ddc803d0e06977a3c796043949813a8900eb20197e2384ecc38991886eefe8495ff4faeb8e6e12151d2e18a72ce73c9496b870a2c091ab"} 10:36:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:47 INFO - Contents: 10:36:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2126d06bb6810fbe0fab00e2d2ecf595e322a6f70892d15ae5d9bef61ac33ed7355a20dde896d570ba2bf452e6bc428037e8f83c823cfdf28831f2a0fcdc8c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33a3391f6858027fa5ddc803d0e06977a3c796043949813a8900eb20197e2384ecc38991886eefe8495ff4faeb8e6e12151d2e18a72ce73c9496b870a2c091ab"} 10:36:47 INFO - Copying logs to upload dir... 10:36:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.708131 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 10:36:46.443357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 10:36:46.446804) ========= 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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2126d06bb6810fbe0fab00e2d2ecf595e322a6f70892d15ae5d9bef61ac33ed7355a20dde896d570ba2bf452e6bc428037e8f83c823cfdf28831f2a0fcdc8c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33a3391f6858027fa5ddc803d0e06977a3c796043949813a8900eb20197e2384ecc38991886eefe8495ff4faeb8e6e12151d2e18a72ce73c9496b870a2c091ab"} build_url:https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/dU6vXmzrRSmgmSROD9BAYg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2126d06bb6810fbe0fab00e2d2ecf595e322a6f70892d15ae5d9bef61ac33ed7355a20dde896d570ba2bf452e6bc428037e8f83c823cfdf28831f2a0fcdc8c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33a3391f6858027fa5ddc803d0e06977a3c796043949813a8900eb20197e2384ecc38991886eefe8495ff4faeb8e6e12151d2e18a72ce73c9496b870a2c091ab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 10:36:46.471644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:36:46.472030) ========= 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=919420d7ee4ef147bef0346300000385-1451499247.947410-228029518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:36:46.555593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 10:36:46.555935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 10:36:46.556271) ========= ========= Total master_lag: 0.27 =========