builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1470745408.09 results: success (0) buildid: 20160809023001 builduid: 7ad9101e5ff64756950b2ecf6a3853b1 revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.085552) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.086009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.086618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.134858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.135219) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 05:23: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-08-09 05:23:29 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.235906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.236260) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019143 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.287710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:28.288104) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2edc35144ebf50ca6339e686e766e200cc4b04b8 --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 2edc35144ebf50ca6339e686e766e200cc4b04b8 --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=a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 05:23:29,429 truncating revision to first 12 chars 2016-08-09 05:23:29,429 Setting DEBUG logging. 2016-08-09 05:23:29,429 attempt 1/10 2016-08-09 05:23:29,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2edc35144ebf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 05:23:30,071 unpacking tar archive at: fx-team-2edc35144ebf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:29.252299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:29.252719) ========= script_repo_revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:29.253182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:29.253497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:23:29.263741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-09 05:23:29.264134) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:30 INFO - MultiFileLogger online at 20160809 05:23:30 in /builds/slave/test 05:23:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:23:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:30 INFO - {'append_to_log': False, 05:23:30 INFO - 'base_work_dir': '/builds/slave/test', 05:23:30 INFO - 'blob_upload_branch': 'Fx-Team', 05:23:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:30 INFO - 'branch': 'Fx-Team', 05:23:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:30 INFO - 'config_files': ('talos/linux_config.py',), 05:23:30 INFO - 'default_actions': ('clobber', 05:23:30 INFO - 'read-buildbot-config', 05:23:30 INFO - 'download-and-extract', 05:23:30 INFO - 'populate-webroot', 05:23:30 INFO - 'create-virtualenv', 05:23:30 INFO - 'install', 05:23:30 INFO - 'run-tests'), 05:23:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:30 INFO - 'download_minidump_stackwalk': True, 05:23:30 INFO - 'download_symbols': 'ondemand', 05:23:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:30 INFO - 'installer_path': 'installer.exe', 05:23:30 INFO - 'log_level': 'info', 05:23:30 INFO - 'log_name': 'talos', 05:23:30 INFO - 'log_to_console': True, 05:23:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:30 INFO - 'opt_config_files': (), 05:23:30 INFO - 'pip_index': False, 05:23:30 INFO - 'sps_profile': False, 05:23:30 INFO - 'sps_profile_interval': 0, 05:23:30 INFO - 'suite': 'dromaeojs-e10s', 05:23:30 INFO - 'system_bits': '32', 05:23:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:30 INFO - 'title': 'talos-linux64-ix-062', 05:23:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:30 INFO - 'use_talos_json': True, 05:23:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:30 INFO - 'work_dir': 'build'} 05:23:30 INFO - [mozharness: 2016-08-09 12:23:30.498076Z] Running clobber step. 05:23:30 INFO - Running pre-action listener: _resource_record_pre_action 05:23:30 INFO - Running main action method: clobber 05:23:30 INFO - rmtree: /builds/slave/test/build 05:23:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:30 INFO - Running post-action listener: _resource_record_post_action 05:23:30 INFO - [mozharness: 2016-08-09 12:23:30.956806Z] Finished clobber step (success) 05:23:30 INFO - [mozharness: 2016-08-09 12:23:30.956914Z] Running read-buildbot-config step. 05:23:30 INFO - Running pre-action listener: _resource_record_pre_action 05:23:30 INFO - Running main action method: read_buildbot_config 05:23:30 INFO - Using buildbot properties: 05:23:30 INFO - { 05:23:30 INFO - "project": "", 05:23:30 INFO - "product": "firefox", 05:23:30 INFO - "script_repo_revision": "production", 05:23:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:23:30 INFO - "repository": "", 05:23:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:23:30 INFO - "buildid": "20160809023001", 05:23:30 INFO - "pgo_build": "True", 05:23:30 INFO - "basedir": "/builds/slave/test", 05:23:30 INFO - "buildnumber": 1031, 05:23:30 INFO - "slavename": "talos-linux64-ix-062", 05:23:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:23:30 INFO - "platform": "ubuntu64_hw", 05:23:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:23:30 INFO - "branch": "fx-team", 05:23:30 INFO - "repo_path": "integration/fx-team", 05:23:30 INFO - "revision": "2edc35144ebf50ca6339e686e766e200cc4b04b8", 05:23:30 INFO - "stage_platform": "linux64-pgo", 05:23:30 INFO - "builduid": "7ad9101e5ff64756950b2ecf6a3853b1", 05:23:30 INFO - "slavebuilddir": "test" 05:23:30 INFO - } 05:23:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:23:30 INFO - Running post-action listener: _resource_record_post_action 05:23:30 INFO - [mozharness: 2016-08-09 12:23:30.959328Z] Finished read-buildbot-config step (success) 05:23:30 INFO - [mozharness: 2016-08-09 12:23:30.959417Z] Running download-and-extract step. 05:23:30 INFO - Running pre-action listener: _resource_record_pre_action 05:23:30 INFO - Running main action method: download_and_extract 05:23:30 INFO - mkdir: /builds/slave/test/build/tests 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:30 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:23:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:23:31 INFO - Downloaded 1361 bytes. 05:23:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:23:31 INFO - Using the following test package requirements: 05:23:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:23:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:23:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'jsshell-linux-x86_64.zip'], 05:23:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:23:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:23:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:23:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:23:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:23:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:23:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:31 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:23:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:23:32 INFO - Downloaded 21828529 bytes. 05:23:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:23:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:23:33 INFO - Return code: 0 05:23:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:33 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:23:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:23:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:23:34 INFO - Downloaded 21828529 bytes. 05:23:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:23:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:23:35 INFO - Return code: 0 05:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:35 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:23:36 INFO - Downloaded 14413723 bytes. 05:23:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:23:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:23:36 INFO - Return code: 0 05:23:36 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:36 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:23:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:23:37 INFO - Downloaded 59972166 bytes. 05:23:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:23:37 INFO - mkdir: /builds/slave/test/properties 05:23:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:37 INFO - Contents: 05:23:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:23:38 INFO - Running post-action listener: _resource_record_post_action 05:23:38 INFO - Running post-action listener: set_extra_try_arguments 05:23:38 INFO - [mozharness: 2016-08-09 12:23:38.296433Z] Finished download-and-extract step (success) 05:23:38 INFO - [mozharness: 2016-08-09 12:23:38.296697Z] Running populate-webroot step. 05:23:38 INFO - Running pre-action listener: _resource_record_pre_action 05:23:38 INFO - Running main action method: populate_webroot 05:23:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:38 INFO - '--tppagecycles', 05:23:38 INFO - '7'], 05:23:38 INFO - 'tests': ['tsvgm']}}, 05:23:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:23:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:23:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:23:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['damp', 'tps']}, 05:23:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'tests': ['damp', 'tps']}, 05:23:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['dromaeo_dom']}, 05:23:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['basic_compositor_video']}, 05:23:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:23:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['a11yr', 05:23:38 INFO - 'ts_paint', 05:23:38 INFO - 'tpaint', 05:23:38 INFO - 'sessionrestore', 05:23:38 INFO - 'sessionrestore_no_auto_restore', 05:23:38 INFO - 'tabpaint']}, 05:23:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:23:38 INFO - 'ts_paint', 05:23:38 INFO - 'tpaint', 05:23:38 INFO - 'sessionrestore', 05:23:38 INFO - 'sessionrestore_no_auto_restore', 05:23:38 INFO - 'tabpaint']}, 05:23:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:23:38 INFO - 'ts_paint', 05:23:38 INFO - 'tpaint', 05:23:38 INFO - 'sessionrestore', 05:23:38 INFO - 'sessionrestore_no_auto_restore', 05:23:38 INFO - 'tabpaint']}, 05:23:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:23:38 INFO - 'ts_paint', 05:23:38 INFO - 'tpaint', 05:23:38 INFO - 'sessionrestore', 05:23:38 INFO - 'sessionrestore_no_auto_restore', 05:23:38 INFO - 'tabpaint']}, 05:23:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['a11yr', 05:23:38 INFO - 'ts_paint', 05:23:38 INFO - 'tpaint', 05:23:38 INFO - 'sessionrestore', 05:23:38 INFO - 'sessionrestore_no_auto_restore', 05:23:38 INFO - 'tabpaint']}, 05:23:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['a11yr', 05:23:38 INFO - 'ts_paint', 05:23:38 INFO - 'tpaint', 05:23:38 INFO - 'sessionrestore', 05:23:38 INFO - 'sessionrestore_no_auto_restore', 05:23:38 INFO - 'tabpaint']}, 05:23:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['tsvgx', 05:23:38 INFO - 'tsvgr_opacity', 05:23:38 INFO - 'tart', 05:23:38 INFO - 'tscrollx', 05:23:38 INFO - 'cart']}, 05:23:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:23:38 INFO - 'tsvgr_opacity', 05:23:38 INFO - 'tart', 05:23:38 INFO - 'tscrollx', 05:23:38 INFO - 'cart']}, 05:23:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'talos_options': ['--disable-e10s'], 05:23:38 INFO - 'tests': ['tp5o']}, 05:23:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'tests': ['tp5o']}, 05:23:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'talos_options': ['--disable-e10s', 05:23:38 INFO - '--xperf_path', 05:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:38 INFO - 'tests': ['tp5n']}, 05:23:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:38 INFO - 'talos_options': ['--xperf_path', 05:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:38 INFO - 'tests': ['tp5n']}}, 05:23:38 INFO - 'talos.zip': {'path': '', 05:23:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:38 INFO - Running post-action listener: _resource_record_post_action 05:23:38 INFO - [mozharness: 2016-08-09 12:23:38.317428Z] Finished populate-webroot step (success) 05:23:38 INFO - [mozharness: 2016-08-09 12:23:38.317516Z] Running create-virtualenv step. 05:23:38 INFO - Running pre-action listener: _resource_record_pre_action 05:23:38 INFO - Running main action method: create_virtualenv 05:23:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:38 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 05:23:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:38 INFO - Using real prefix '/usr' 05:23:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:23:41 INFO - Installing pip.................done. 05:23:41 INFO - Return code: 0 05:23:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:23:41 INFO - Using env: {'DISPLAY': ':0', 05:23:41 INFO - 'HOME': '/home/cltbld', 05:23:41 INFO - 'LANG': 'en_US.UTF-8', 05:23:41 INFO - 'LANGUAGE': 'en_US:en', 05:23:41 INFO - 'LOGNAME': 'cltbld', 05:23:41 INFO - 'MAIL': '/var/mail/cltbld', 05:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:41 INFO - 'MOZ_NO_REMOTE': '1', 05:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:41 INFO - 'NO_EM_RESTART': '1', 05:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:41 INFO - 'PWD': '/builds/slave/test', 05:23:41 INFO - 'SHELL': '/bin/bash', 05:23:41 INFO - 'SHLVL': '1', 05:23:41 INFO - 'TERM': 'linux', 05:23:41 INFO - 'TMOUT': '86400', 05:23:41 INFO - 'USER': 'cltbld', 05:23:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:41 INFO - '_': '/tools/buildbot/bin/python'} 05:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:41 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 05:23:41 INFO - Cleaning up... 05:23:41 INFO - Return code: 0 05:23:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 05:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 05:23:41 INFO - Using env: {'DISPLAY': ':0', 05:23:41 INFO - 'HOME': '/home/cltbld', 05:23:41 INFO - 'LANG': 'en_US.UTF-8', 05:23:41 INFO - 'LANGUAGE': 'en_US:en', 05:23:41 INFO - 'LOGNAME': 'cltbld', 05:23:41 INFO - 'MAIL': '/var/mail/cltbld', 05:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:41 INFO - 'MOZ_NO_REMOTE': '1', 05:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:41 INFO - 'NO_EM_RESTART': '1', 05:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:41 INFO - 'PWD': '/builds/slave/test', 05:23:41 INFO - 'SHELL': '/bin/bash', 05:23:41 INFO - 'SHLVL': '1', 05:23:41 INFO - 'TERM': 'linux', 05:23:41 INFO - 'TMOUT': '86400', 05:23:41 INFO - 'USER': 'cltbld', 05:23:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:41 INFO - '_': '/tools/buildbot/bin/python'} 05:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:41 INFO - Downloading/unpacking psutil>=3.1.1 05:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:43 INFO - Installing collected packages: psutil 05:23:43 INFO - Running setup.py install for psutil 05:23:43 INFO - building 'psutil._psutil_linux' extension 05:23:43 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 05:23:43 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 05:23:43 INFO - building 'psutil._psutil_posix' extension 05:23:43 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 05:23:43 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 05:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:43 INFO - Successfully installed psutil 05:23:43 INFO - Cleaning up... 05:23:44 INFO - Return code: 0 05:23:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 05:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 05:23:44 INFO - Using env: {'DISPLAY': ':0', 05:23:44 INFO - 'HOME': '/home/cltbld', 05:23:44 INFO - 'LANG': 'en_US.UTF-8', 05:23:44 INFO - 'LANGUAGE': 'en_US:en', 05:23:44 INFO - 'LOGNAME': 'cltbld', 05:23:44 INFO - 'MAIL': '/var/mail/cltbld', 05:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:44 INFO - 'MOZ_NO_REMOTE': '1', 05:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:44 INFO - 'NO_EM_RESTART': '1', 05:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:44 INFO - 'PWD': '/builds/slave/test', 05:23:44 INFO - 'SHELL': '/bin/bash', 05:23:44 INFO - 'SHLVL': '1', 05:23:44 INFO - 'TERM': 'linux', 05:23:44 INFO - 'TMOUT': '86400', 05:23:44 INFO - 'USER': 'cltbld', 05:23:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:44 INFO - '_': '/tools/buildbot/bin/python'} 05:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:23:44 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 05:23:44 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 05:23:44 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 05:23:44 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 05:23:44 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 05:23:44 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 05:23:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:23:46 INFO - Installing collected packages: mozsystemmonitor 05:23:46 INFO - Running setup.py install for mozsystemmonitor 05:23:46 INFO - Successfully installed mozsystemmonitor 05:23:46 INFO - Cleaning up... 05:23:46 INFO - Return code: 0 05:23:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 05:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 05:23:46 INFO - Using env: {'DISPLAY': ':0', 05:23:46 INFO - 'HOME': '/home/cltbld', 05:23:46 INFO - 'LANG': 'en_US.UTF-8', 05:23:46 INFO - 'LANGUAGE': 'en_US:en', 05:23:46 INFO - 'LOGNAME': 'cltbld', 05:23:46 INFO - 'MAIL': '/var/mail/cltbld', 05:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:46 INFO - 'MOZ_NO_REMOTE': '1', 05:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:46 INFO - 'NO_EM_RESTART': '1', 05:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:46 INFO - 'PWD': '/builds/slave/test', 05:23:46 INFO - 'SHELL': '/bin/bash', 05:23:46 INFO - 'SHLVL': '1', 05:23:46 INFO - 'TERM': 'linux', 05:23:46 INFO - 'TMOUT': '86400', 05:23:46 INFO - 'USER': 'cltbld', 05:23:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:46 INFO - '_': '/tools/buildbot/bin/python'} 05:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:23:46 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 05:23:46 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 05:23:46 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 05:23:46 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 05:23:46 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 05:23:46 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 05:23:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:48 INFO - warning: no files found matching '*.txt' 05:23:48 INFO - no previously-included directories found matching 'build' 05:23:48 INFO - no previously-included directories found matching 'dist' 05:23:48 INFO - no previously-included directories found matching '.git*' 05:23:48 INFO - Installing collected packages: jsonschema, functools32 05:23:48 INFO - Running setup.py install for functools32 05:23:48 INFO - warning: no files found matching '*.txt' 05:23:48 INFO - no previously-included directories found matching 'build' 05:23:48 INFO - no previously-included directories found matching 'dist' 05:23:48 INFO - no previously-included directories found matching '.git*' 05:23:48 INFO - Successfully installed jsonschema functools32 05:23:48 INFO - Cleaning up... 05:23:48 INFO - Return code: 0 05:23:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 05:23:48 INFO - Using env: {'DISPLAY': ':0', 05:23:48 INFO - 'HOME': '/home/cltbld', 05:23:48 INFO - 'LANG': 'en_US.UTF-8', 05:23:48 INFO - 'LANGUAGE': 'en_US:en', 05:23:48 INFO - 'LOGNAME': 'cltbld', 05:23:48 INFO - 'MAIL': '/var/mail/cltbld', 05:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:48 INFO - 'MOZ_NO_REMOTE': '1', 05:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:48 INFO - 'NO_EM_RESTART': '1', 05:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:48 INFO - 'PWD': '/builds/slave/test', 05:23:48 INFO - 'SHELL': '/bin/bash', 05:23:48 INFO - 'SHLVL': '1', 05:23:48 INFO - 'TERM': 'linux', 05:23:48 INFO - 'TMOUT': '86400', 05:23:48 INFO - 'USER': 'cltbld', 05:23:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:48 INFO - '_': '/tools/buildbot/bin/python'} 05:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:23:49 INFO - Cleaning up... 05:23:49 INFO - Return code: 0 05:23:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:23:49 INFO - Using env: {'DISPLAY': ':0', 05:23:49 INFO - 'HOME': '/home/cltbld', 05:23:49 INFO - 'LANG': 'en_US.UTF-8', 05:23:49 INFO - 'LANGUAGE': 'en_US:en', 05:23:49 INFO - 'LOGNAME': 'cltbld', 05:23:49 INFO - 'MAIL': '/var/mail/cltbld', 05:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:49 INFO - 'MOZ_NO_REMOTE': '1', 05:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:49 INFO - 'NO_EM_RESTART': '1', 05:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:49 INFO - 'PWD': '/builds/slave/test', 05:23:49 INFO - 'SHELL': '/bin/bash', 05:23:49 INFO - 'SHLVL': '1', 05:23:49 INFO - 'TERM': 'linux', 05:23:49 INFO - 'TMOUT': '86400', 05:23:49 INFO - 'USER': 'cltbld', 05:23:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:49 INFO - '_': '/tools/buildbot/bin/python'} 05:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:23:49 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 05:23:49 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 05:23:49 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 05:23:49 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 05:23:49 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 05:23:49 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 05:23:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:51 INFO - Downloading docopt-0.6.1.tar.gz 05:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:51 INFO - Running setup.py install for blobuploader 05:23:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:52 INFO - Running setup.py install for requests 05:23:52 INFO - Running setup.py install for docopt 05:23:52 INFO - Successfully installed blobuploader requests docopt 05:23:52 INFO - Cleaning up... 05:23:52 INFO - Return code: 0 05:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:23:52 INFO - Using env: {'DISPLAY': ':0', 05:23:52 INFO - 'HOME': '/home/cltbld', 05:23:52 INFO - 'LANG': 'en_US.UTF-8', 05:23:52 INFO - 'LANGUAGE': 'en_US:en', 05:23:52 INFO - 'LOGNAME': 'cltbld', 05:23:52 INFO - 'MAIL': '/var/mail/cltbld', 05:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:52 INFO - 'MOZ_NO_REMOTE': '1', 05:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:52 INFO - 'NO_EM_RESTART': '1', 05:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:52 INFO - 'PWD': '/builds/slave/test', 05:23:52 INFO - 'SHELL': '/bin/bash', 05:23:52 INFO - 'SHLVL': '1', 05:23:52 INFO - 'TERM': 'linux', 05:23:52 INFO - 'TMOUT': '86400', 05:23:52 INFO - 'USER': 'cltbld', 05:23:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:52 INFO - '_': '/tools/buildbot/bin/python'} 05:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:52 INFO - Running setup.py (path:/tmp/pip-7I3Xza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:52 INFO - Running setup.py (path:/tmp/pip-G2fEAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:52 INFO - Running setup.py (path:/tmp/pip-DeuGtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:52 INFO - Running setup.py (path:/tmp/pip-wtKX4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:53 INFO - Running setup.py (path:/tmp/pip-XVxURQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:53 INFO - Running setup.py (path:/tmp/pip-6uvI28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:53 INFO - Running setup.py (path:/tmp/pip-bzhcY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:53 INFO - Running setup.py (path:/tmp/pip-iLhF9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:53 INFO - Running setup.py (path:/tmp/pip-nn5QBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:53 INFO - Running setup.py (path:/tmp/pip-xip1ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:53 INFO - Running setup.py (path:/tmp/pip-K57wcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:53 INFO - Running setup.py (path:/tmp/pip-rANsZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:53 INFO - Running setup.py (path:/tmp/pip-XacJSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:53 INFO - Running setup.py (path:/tmp/pip-udeXsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:53 INFO - Running setup.py (path:/tmp/pip-Ja3UVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:53 INFO - Running setup.py (path:/tmp/pip-ZaWCKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:53 INFO - Running setup.py (path:/tmp/pip-9UNwzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:54 INFO - Running setup.py install for manifestparser 05:23:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Running setup.py install for mozcrash 05:23:54 INFO - Running setup.py install for mozdebug 05:23:54 INFO - Running setup.py install for mozdevice 05:23:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Running setup.py install for mozfile 05:23:54 INFO - Running setup.py install for mozhttpd 05:23:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Running setup.py install for mozinfo 05:23:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Running setup.py install for mozInstall 05:23:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:54 INFO - Running setup.py install for mozleak 05:23:54 INFO - Running setup.py install for mozlog 05:23:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:55 INFO - Running setup.py install for moznetwork 05:23:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:55 INFO - Running setup.py install for mozprocess 05:23:55 INFO - Running setup.py install for mozprofile 05:23:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:55 INFO - Running setup.py install for mozrunner 05:23:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:55 INFO - Running setup.py install for mozscreenshot 05:23:55 INFO - Running setup.py install for moztest 05:23:55 INFO - Running setup.py install for mozversion 05:23:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:55 INFO - Cleaning up... 05:23:55 INFO - Return code: 0 05:23:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:23:55 INFO - Using env: {'DISPLAY': ':0', 05:23:55 INFO - 'HOME': '/home/cltbld', 05:23:55 INFO - 'LANG': 'en_US.UTF-8', 05:23:55 INFO - 'LANGUAGE': 'en_US:en', 05:23:55 INFO - 'LOGNAME': 'cltbld', 05:23:55 INFO - 'MAIL': '/var/mail/cltbld', 05:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:55 INFO - 'MOZ_NO_REMOTE': '1', 05:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:55 INFO - 'NO_EM_RESTART': '1', 05:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:55 INFO - 'PWD': '/builds/slave/test', 05:23:55 INFO - 'SHELL': '/bin/bash', 05:23:55 INFO - 'SHLVL': '1', 05:23:55 INFO - 'TERM': 'linux', 05:23:55 INFO - 'TMOUT': '86400', 05:23:55 INFO - 'USER': 'cltbld', 05:23:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:55 INFO - '_': '/tools/buildbot/bin/python'} 05:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:56 INFO - Running setup.py (path:/tmp/pip-M1LDRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:56 INFO - Running setup.py (path:/tmp/pip-Lj4IDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:56 INFO - Running setup.py (path:/tmp/pip-jegvUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:56 INFO - Running setup.py (path:/tmp/pip-bVr_pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:56 INFO - Running setup.py (path:/tmp/pip-TJKwdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:56 INFO - Running setup.py (path:/tmp/pip-wvc4s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:56 INFO - Running setup.py (path:/tmp/pip-RpvFRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:56 INFO - Running setup.py (path:/tmp/pip-gaUO4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:56 INFO - Running setup.py (path:/tmp/pip-FuNYJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:56 INFO - Running setup.py (path:/tmp/pip-nIoD45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:56 INFO - Running setup.py (path:/tmp/pip-Jzp56W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:56 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:56 INFO - Running setup.py (path:/tmp/pip-oaDxGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:56 INFO - Running setup.py (path:/tmp/pip-atxEgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:57 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)) 05:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:57 INFO - Running setup.py (path:/tmp/pip-FO0RKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:57 INFO - Running setup.py (path:/tmp/pip-LWn0PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:57 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)) 05:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:57 INFO - Running setup.py (path:/tmp/pip-N5uVgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:57 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)) 05:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:57 INFO - Running setup.py (path:/tmp/pip-vde84r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:57 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)) 05:23:57 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:57 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:57 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)) 05:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23:59 INFO - Downloading blessings-1.6.tar.gz 05:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:59 INFO - Installing collected packages: blessings 05:23:59 INFO - Running setup.py install for blessings 05:23:59 INFO - Successfully installed blessings 05:23:59 INFO - Cleaning up... 05:23:59 INFO - Return code: 0 05:23:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:59 INFO - Reading from file tmpfile_stdout 05:23:59 INFO - Current package versions: 05:23:59 INFO - argparse == 1.2.1 05:23:59 INFO - blessings == 1.6 05:23:59 INFO - blobuploader == 1.2.4 05:23:59 INFO - docopt == 0.6.1 05:23:59 INFO - functools32 == 3.2.3-2 05:23:59 INFO - jsonschema == 2.5.1 05:23:59 INFO - manifestparser == 1.1 05:23:59 INFO - mozInstall == 1.12 05:23:59 INFO - mozcrash == 0.17 05:23:59 INFO - mozdebug == 0.1 05:23:59 INFO - mozdevice == 0.48 05:23:59 INFO - mozfile == 1.2 05:23:59 INFO - mozhttpd == 0.7 05:23:59 INFO - mozinfo == 0.9 05:23:59 INFO - mozleak == 0.1 05:23:59 INFO - mozlog == 3.3 05:23:59 INFO - moznetwork == 0.27 05:23:59 INFO - mozprocess == 0.23 05:23:59 INFO - mozprofile == 0.28 05:23:59 INFO - mozrunner == 6.12 05:23:59 INFO - mozscreenshot == 0.1 05:23:59 INFO - mozsystemmonitor == 0.3 05:23:59 INFO - moztest == 0.7 05:23:59 INFO - mozversion == 1.4 05:23:59 INFO - psutil == 3.1.1 05:23:59 INFO - requests == 1.2.3 05:23:59 INFO - wsgiref == 0.1.2 05:23:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:23:59 INFO - Using env: {'DISPLAY': ':0', 05:23:59 INFO - 'HOME': '/home/cltbld', 05:23:59 INFO - 'LANG': 'en_US.UTF-8', 05:23:59 INFO - 'LANGUAGE': 'en_US:en', 05:23:59 INFO - 'LOGNAME': 'cltbld', 05:23:59 INFO - 'MAIL': '/var/mail/cltbld', 05:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:59 INFO - 'MOZ_NO_REMOTE': '1', 05:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:59 INFO - 'NO_EM_RESTART': '1', 05:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:59 INFO - 'PWD': '/builds/slave/test', 05:23:59 INFO - 'SHELL': '/bin/bash', 05:23:59 INFO - 'SHLVL': '1', 05:23:59 INFO - 'TERM': 'linux', 05:23:59 INFO - 'TMOUT': '86400', 05:23:59 INFO - 'USER': 'cltbld', 05:23:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:59 INFO - '_': '/tools/buildbot/bin/python'} 05:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 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)) 05:23:59 INFO - Cleaning up... 05:23:59 INFO - Return code: 0 05:23:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1dc7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', '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 05:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:23:59 INFO - Using env: {'DISPLAY': ':0', 05:23:59 INFO - 'HOME': '/home/cltbld', 05:23:59 INFO - 'LANG': 'en_US.UTF-8', 05:23:59 INFO - 'LANGUAGE': 'en_US:en', 05:23:59 INFO - 'LOGNAME': 'cltbld', 05:23:59 INFO - 'MAIL': '/var/mail/cltbld', 05:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:59 INFO - 'MOZ_NO_REMOTE': '1', 05:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:59 INFO - 'NO_EM_RESTART': '1', 05:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:59 INFO - 'PWD': '/builds/slave/test', 05:23:59 INFO - 'SHELL': '/bin/bash', 05:23:59 INFO - 'SHLVL': '1', 05:23:59 INFO - 'TERM': 'linux', 05:23:59 INFO - 'TMOUT': '86400', 05:23:59 INFO - 'USER': 'cltbld', 05:23:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:59 INFO - '_': '/tools/buildbot/bin/python'} 05:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:24:00 INFO - Cleaning up... 05:24:00 INFO - Return code: 0 05:24:00 INFO - Running post-action listener: _resource_record_post_action 05:24:00 INFO - Running post-action listener: _start_resource_monitoring 05:24:00 INFO - Starting resource monitoring. 05:24:00 INFO - [mozharness: 2016-08-09 12:24:00.164194Z] Finished create-virtualenv step (success) 05:24:00 INFO - [mozharness: 2016-08-09 12:24:00.164638Z] Running install step. 05:24:00 INFO - Running pre-action listener: _resource_record_pre_action 05:24:00 INFO - Running main action method: install 05:24:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:00 INFO - Reading from file tmpfile_stdout 05:24:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:00 INFO - Reading from file tmpfile_stdout 05:24:00 INFO - Output received: 05:24:00 INFO - Usage: mozinstall [options] installer 05:24:00 INFO - Options: 05:24:00 INFO - -h, --help show this help message and exit 05:24:00 INFO - -d DEST, --destination=DEST 05:24:00 INFO - Directory to install application into. [default: 05:24:00 INFO - "/builds/slave/test"] 05:24:00 INFO - --app=APP Application being installed. [default: firefox] 05:24:00 INFO - mkdir: /builds/slave/test/build/application 05:24:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:24:17 INFO - Reading from file tmpfile_stdout 05:24:17 INFO - Output received: 05:24:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:17 INFO - Running post-action listener: _resource_record_post_action 05:24:17 INFO - [mozharness: 2016-08-09 12:24:17.525831Z] Finished install step (success) 05:24:17 INFO - [mozharness: 2016-08-09 12:24:17.526077Z] Running run-tests step. 05:24:17 INFO - Running pre-action listener: _resource_record_pre_action 05:24:17 INFO - Running main action method: run_tests 05:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:17 INFO - Python 2.7.3 05:24:17 INFO - Return code: 0 05:24:17 INFO - grabbing minidump binary from tooltool 05:24:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:17 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20863b0>, '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 0x20872b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:17 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 05:24:17 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 05:24:17 INFO - Calling ['/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'] with output_timeout 600 05:24:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:17 INFO - Return code: 0 05:24:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:24:17 INFO - Using env: {'DISPLAY': ':0', 05:24:17 INFO - 'HOME': '/home/cltbld', 05:24:17 INFO - 'LANG': 'en_US.UTF-8', 05:24:17 INFO - 'LANGUAGE': 'en_US:en', 05:24:17 INFO - 'LOGNAME': 'cltbld', 05:24:17 INFO - 'MAIL': '/var/mail/cltbld', 05:24:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:17 INFO - 'MOZ_NO_REMOTE': '1', 05:24:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:17 INFO - 'NO_EM_RESTART': '1', 05:24:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:17 INFO - 'PWD': '/builds/slave/test', 05:24:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:17 INFO - 'SHELL': '/bin/bash', 05:24:17 INFO - 'SHLVL': '1', 05:24:17 INFO - 'TERM': 'linux', 05:24:17 INFO - 'TMOUT': '86400', 05:24:17 INFO - 'USER': 'cltbld', 05:24:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427', 05:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:17 INFO - '_': '/tools/buildbot/bin/python'} 05:24:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:24:17 INFO - mozversion application_buildid: 20160809023001 05:24:17 INFO - mozversion application_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 05:24:17 INFO - mozversion application_display_name: Nightly 05:24:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:17 INFO - mozversion application_name: Firefox 05:24:17 INFO - mozversion application_remotingname: firefox 05:24:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:24:17 INFO - mozversion application_vendor: Mozilla 05:24:17 INFO - mozversion application_version: 51.0a1 05:24:17 INFO - mozversion platform_buildid: 20160809023001 05:24:17 INFO - mozversion platform_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 05:24:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:24:17 INFO - mozversion platform_version: 51.0a1 05:24:17 INFO - using testdate: 1470745457 05:24:17 INFO - actual date: 1470745457 05:24:17 INFO - starting webserver on 'localhost:48448' 05:24:17 INFO - SUITE-START | Running 2 tests 05:24:17 INFO - TEST-START | dromaeo_css 05:24:17 INFO - operating with platform_type : linux_ 05:24:17 INFO - Initialising browser for dromaeo_css test... 05:24:17 INFO - TEST-INFO | started process 23057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxdejY/profile http://localhost:48448/getInfo.html) 05:24:21 INFO - PROCESS | 23057 | __metrics Screen width/height:1600/1200 05:24:21 INFO - PROCESS | 23057 | colorDepth:24 05:24:21 INFO - PROCESS | 23057 | Browser inner width/height: 1024/697 05:24:21 INFO - PROCESS | 23057 | __metrics 05:24:22 ERROR - PROCESS | 23057 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:24:23 INFO - TEST-INFO | 23057: exit 0 05:24:23 INFO - Browser initialized. 05:24:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:24:23 INFO - TEST-INFO | started process 23177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxdejY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:35 INFO - PROCESS | 23177 | RSS: Main: 164417536 05:24:35 INFO - PROCESS | 23177 | 05:25:24 INFO - PROCESS | 23177 | 1470745524617 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] 05:27:33 INFO - PROCESS | 23177 | Cycle 1(1): loaded http://localhost:48448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48448/tests/dromaeo/cssquery-ext.html) 05:27:34 INFO - PROCESS | 23177 | RSS: Main: 168640512 05:27:34 INFO - PROCESS | 23177 | 05:30:36 INFO - PROCESS | 23177 | Cycle 1(1): loaded http://localhost:48448/tests/dromaeo/cssquery-ext.html (next: http://localhost:48448/tests/dromaeo/cssquery-jquery.html) 05:30:37 INFO - PROCESS | 23177 | RSS: Main: 167096320 05:30:37 INFO - PROCESS | 23177 | 05:33:39 INFO - PROCESS | 23177 | Cycle 1(1): loaded http://localhost:48448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48448/tests/dromaeo/cssquery-mootools.html) 05:33:39 INFO - PROCESS | 23177 | RSS: Main: 170332160 05:33:39 INFO - PROCESS | 23177 | 05:36:41 INFO - PROCESS | 23177 | Cycle 1(1): loaded http://localhost:48448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48448/tests/dromaeo/cssquery-prototype.html) 05:36:42 INFO - PROCESS | 23177 | RSS: Main: 165134336 05:36:42 INFO - PROCESS | 23177 | 05:39:44 INFO - PROCESS | 23177 | Cycle 1(1): loaded http://localhost:48448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48448/tests/dromaeo/cssquery-yui.html) 05:39:45 INFO - PROCESS | 23177 | RSS: Main: 166670336 05:39:45 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | Cycle 1(1): loaded http://localhost:48448/tests/dromaeo/cssquery-yui.html (next: http://localhost:48448/tests/dromaeo/cssquery-dojo.html) 05:42:48 INFO - PROCESS | 23177 | RSS: Main: 170151936 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | __start_tp_report 05:42:48 INFO - PROCESS | 23177 | _x_x_mozilla_page_load 05:42:48 INFO - PROCESS | 23177 | _x_x_mozilla_page_load_details 05:42:48 INFO - PROCESS | 23177 | |i|pagename|runs| 05:42:48 INFO - PROCESS | 23177 | |0;dojo.html;3023.123294244669;3032.2116249775054;3059.0211132437616;3060.2502386915207;3061.8162910225383;5218.478152184784;5249.8950020999555;5271.288376069229;5284.101702710539;5315.654482458643;5335.279737235472;5366.597505187116;5391.245225668409;5402.621816472849;5424.267723857278;4820.662553621248;4878.341423907763;4891.779869905863;4934.235193544989;4976.502349765013;4929.2606109083745;5001.474845141262;5053.065182941149;5054.090263752523;5054.21659642756;564.6871686108163;4830.903381932377;5024.547790698854;5058.013687330972;5068.949310506885;4860.1008813369635;4891.608671306287;4910.459849416561;4956.776945037482;4964.478729733362;4828.444728856191;4845.466998630148;4865.34317867087;4868.099401610678;4891.9755401222765;5168;5261.1319132343115;5268.315119034501;5308.814191503279;5320.201969704536;5696;5732.799352022701;5739.454751798572;5781.364049954502;5792.4497172768515;5764.51001664859;5769.451902069297;5779.624324418942;5821.563382746311;5829;5259.710715910662;5353.973230133864;5415.945840541623;5421.891562168735;5422.810201642924;5894.938910996062;5903.911441328383;5954.047352423591;6019.638821670714;6058.182145410401;5686.630369026083;5717.085266357446;5718.485336319751;5735.426457354315;5739.512141467939;5368.946310536923;5776.480116789509;5785.334686511021;5794.942050579524;5819.301683797971;5708.257926469532;5738.311402631711;5769.336526299446;5775.480206781326;5858.297004359419;5726;5756.7910738744495;5762.049261871828;5799.3620701722775;5822.039363505059;4320.3519472078815;4475.127350166751;4495;4506.842260520866;4520.977395113004;3896.5518965318784;3931.6461518463475;3942.40863870416;3956.762594244297;3975.9662487753394;5498.780048798083;5505.146702261156;5529.198266251371;5529.751161197756;5573.860653483695;5567.3040869891265;5674.092145256739;5831.679257640785;5844.649321040666;5865.4134586541;5366.302380690485;5393.9730301348245;5411.918821217685;5463.535599474009;5469.179623056494;4896.216605343128;4904.411470623477;4918.360613120271;4922.261660750844;4929.457759646436;5807.5644326675665;5907.084401917709;5925.200097986716;5960.612560183574;5968.4926781224085;5685.374608792947;5775.451332123442;5783.19035335045;5801.419858014165;5829.125631155361;5881;5946.1972633693895;5949.375315591974;5953.583249172516;5984.521238300838;5365.570754339721;5521.365043020104;5597.3003374578175;5610.158476228598;5644.8306550803545;5612.298462692163;5707.286589176353;5740.712964351682;5741.885162296814;5781.32341620942;5511.063119269814;5520.66875987442;5550.167474878801;5564.527015203591;5603.663780173039;5402.729863506887;5538.723063846711;5548.861278467909;5561.138023606348;5562.888742225214;5577.163425486209;5577.553795696415;5629.802956896489;5646.0683987141665;5670.858228544319;5534.501894829485;5650.208970744017;5660.29246344207;5675.177099320658;5715.742791574306;5311.070562651597;5367.463253674758;5504.80733174353;5583.832485025456;5590.077637189981 05:42:48 INFO - PROCESS | 23177 | |1;ext.html;548.0132221982134;579.4090028171265;586.9471747542723;592.8577141486044;627.852454673152;39402.408963865564;44118.55881441181;44162.55837441624;44268.77865610671;44403.77798111005;44318.77840610792;44498.77750611251;44505;44545;44592.3311150333;8881.64473421064;8898.510581917992;8942.41874278173;8961.95519022404;8992.145746154138;8940.329475289347;9012.27901767857;9027.864582031274;9045.59294831731;9098.31762617803;9077.455352678828;9097.135772101672;9100.089991000914;9131.178193962542;9165.129312715282;8975.371723979324;8982.910170898273;9035.412698174598;9046.547672616343;9084.68203612877;8823.338249631239;8897.644094236222;8930.86603700945;8958.104189581056;8977.596008179647;42405;42476.663783491895;42660.3600945986;42690.359644605356;42778.57221427808;3531.7704349217474;3744.157564547982;3768.0768211788286;3796.7152463565344;3862.9034274143373;33467.49798753021;33827;34014.6598534014;34048.48927266093;34099.14752131192;3976.1451287973223;4085.5710150434074;4114.074333275019;4177.561356057631;4219.7046206765535;355356;360765;361827.9999999974;362919.96640268713;363400;60394.698026510465;60412.375257484695;60503.394966050655;60789.69605151946;60875;64410;64972.35027649663;65086.34913650898;65486.83184354194;65618.67190664016;16215.108169050816;16293.837061629469;16308.75536866948;16420;16433.506994790176;11774.411279436164;11861.822072668916;11873.762524749456;11898.46456909441;11908.166428349932;17146.742798858028;17600.911995440198;17730.734038989427;17768.378106766202;18072.09639518019;5980.401959803985;6012.398760123952;6060.727267272983;6064.332923378425;6107.358727333655;959.7792507723262;1063.4523220541273;1105.5964572930984;1169.5555688838188;1213.4660749270292;33399.33201336008;33808.492872606934;34044.31911361808;34123.31753364919;34516.654833451845;1034.255336157965;1118.189312748251;1199.8140288255333;1246.975060498803;1255.7990721484518;17040.659186816196;17188.31246750116;17286.740698889527;17342.913285433493;17528.386506472467;527140;533493;535415;535726;535873;61466.385336146064;61520.384796152364;61667.383326166164;61686.69156654188;62106;1336.5388940815403;1354.5191457032809;1385.902986790915;1388.2919710947288;1389.2845184729872;31377.529337059506;32163.51754723634;32553.348933020734;32654.673453265164;32833.671663283065;52025.21962170495;52027;52073.21890171574;52099.99999999849;52296;447679;448980;449204;450417;451005;28973;29601.407971840872;29813.763967702944;42936.35595466133;43227.135457290045;49928.75035624798;50140.49859501358;50313.49686503088;51078.744606276734;52224.21663674972;41843.7907810459;42600;42682.57317426786;42791.786041069594;43888.780556097016;41725.58274417217;41918;42220;43002.569974299855;43380.78309608432;42334.78832605817;42421;43292.35061474144;43423.13153736844;43735.781321094466;36570.63429365672;37543.81228093842;38285.23429531338;38369.2326153481;38797.41803873001;29130;29330.413391731618;29430.411391771617;29490.557641635824;29696.703032969395 05:42:48 INFO - PROCESS | 23177 | |2;jquery.html;380.08778930566655;381.3688345787719;394.6980559871699;397.912459258963;422.4255013182072;13945.302734863268;18435;19287.22851085955;19775.50561235968;19950.401487955365;18990.62018759624;19045.80954190458;19402.902985485052;19719.70420443691;19726;5717.914231286534;5911.438413350725;5953.434423729739;5966.2840459144745;6062.03007518797;5789.842031593698;5883.205767221413;5898.439648233432;5929.288485381739;5940.287165540141;5748.281464816898;5803.854903627401;5894.17481552583;5920.970395148018;5930.97034514829;5787.942120578825;5882.147088672119;5912.733926973275;5916.585838991251;5924.1113832924975;5014.473480284554;5187.559057480119;5219.217117432378;5231.869203269911;5243.239730239094;22784.772152278598;23386.883065584734;23480.530389392115;23820.285391438283;23920.641190382157;2361.6575596538405;2525.8358206716503;2672.024710980478;2928.6144024184864;3169.41365847319;14374.20941848198;14963.326650300764;15069.924650376788;15092.849071509254;15523.223838808015;1978.584497255578;2007.3375785990588;2033.4001469566365;2038.714579958807;2041.3365656161807;82498.58750706268;83266.58366708127;84810;85962.57018714867;86079.56960215222;10425.478726063666;10463.215258855616;10644.148468122532;10754.946225268823;10966.287191332538;14687.485937992118;14746.6727994481;14788.11271323724;14852.108873467627;14875.256237188098;7802.180771018961;8080.8383832323025;8181.304589109874;8262.876056859152;8326.167383261625;7606.847863042708;7741.800020996755;7819.257170568787;7952.880706789403;8014.398920081017;6454.386833250834;6550.526131620347;6593.208814942238;6667.33326667339;6780.593164410151;1925.8844469331605;1951.3072859135086;1967.2327792160781;2014.717939488473;2016.637005339053;930.2418528898926;989.9752506187259;1089.8256278995323;1108.6396921000708;1130.8892176936893;19932.70100948487;20148.697769533468;20329.390118296476;20431.79568204299;20469.15777580025;1016.3444578246989;1036.2176556699644;1048;1066.3015724700333;1087.717193529688;10903.945480272707;11650.708732281591;11683;11696.356700381391;11707.590234341927;433078;442074;444305;445304;448978;49321.753391232814;52033.7398313006;80750.59624701839;80928;83647.5817620908;997.7705127820642;1017.5827910556636;1031.4739482863642;1033.3851358441716;1036.4662198967537;16984.66030679404;17582.472525824247;18244.361447349278;18386.264549417872;18658.16038278308;27633;34169.48745768766;34732.65267347294;41514.37728434015;42070.57929420667;64015;64959;65150;66363.33636663572;66914.66542667255;8538.359623028173;8545.87181192295;8767.298616110824;8841.955790221007;8985.831841860516;12816;13425.731485370043;13426.462941482232;13540.79688804649;13745.869390244528;11836.76326473483;11878.82181767257;12039.699007524881;12104.576339828063;12373.75252494963;11333.716657083638;11810.232334898204;12021.398930053638;12209.267443953391;12475.93762031184;12245.14284000147;12515.87484125147;12595.765096277035;12601.676823933354;12671.796179362946;8542.871856922275;8723.214910658071;8724.3892927497;8955.552222388724;9037.141471560191;8475.576221188792;11286.717832054264;11972.58095966637;11973.401329933642;12161.635150945485 05:42:48 INFO - PROCESS | 23177 | |3;mootools.html;1490.7167638148753;1507.4874542655498;1641.3926847066587;1803.0624075480741;1803.8647101467384;7930.643121059552;8531.616077276522;8698.95650521748;9295.535223238845;9318.114779095984;8740.475571465717;9018.819623607524;9060.048694887024;9106.40808347457;9125.133112354333;2319.8376113672048;2365.2431222008963;2369.099742098;2369.4431808524982;2395.688560487134;2363.633636786301;2367.502824406868;2430.052279610953;2431.173401043645;2439.499902519979;2370.277065495023;2394.090245706629;2394.293683363412;2433.6227884677814;2441.7192022917325;2326.604477238865;2341.2156927429246;2352.752960939111;2355.6348765941307;2406.302172370011;2312.791848733605;2317.501737126509;2317.582835089683;2319.721633404002;2335.614623587106;8945.239654629364;8946.86579701305;9042.593083311267;9053.683121090797;9074.319426043074;5343.412224655285;5413.648112872651;5428.348598168205;5438.646487978269;5510.311211098613;3351.6815902489225;3358.8320583970703;3385.3737058643983;3410.641882602316;3429.4855771634457;1186.7567148734488;1198.1309157713995;1200.4897918384652;1208.6796998795326;1223.9755204895941;12253.081018923616;12347.320897350643;12348.444320005621;12438.689032774162;12467;4443.533428989909;4689.742064186503;4779.474257831635;4792.856214313576;4821.156297647897;10467.42429166388;10530.15758739299;10531.368117912949;10549.314294570828;10574.788504229873;5393.7033463159905;5408.405075441777;5435.619506634498;5441.238226648273;5447.428020057916;4387.254166791653;4786.090642777861;4877.341558889575;4951.282064100686;4959.82640607577;3801.258754542893;4051.622448367569;4060.127072679329;4129.958700413017;4135.1316223593385;1251.5744646819942;1265;1268.498942917561;1289.704326299189;1315.1714419915584;968.4141094637642;980.07872599756;994.8109859126743;1010.2675560218929;1015;6040.637561746222;6049.909251361233;6098.451139397475;6146.938530614637;6150.846228844314;455.26020217147135;456.5480174627162;466.54511850945056;466.6779921853978;467.71001978773376;4196.790160491963;4257.510386305615;4328.415663885398;4335.176316499918;4447.110577884371;10777.407242601575;11289.548418063185;11305.604303849326;11318.434078296052;11334.376609286568;11166.665000050012;11213.94393028046;11215.60745373908;11221.046211072151;11230.606928757617;7792.727254546064;8131.14622964592;8141;8303.211194936592;8451.028131764926;6155.630662160284;6243.344448832807;6278.215223097113;6396.0405939109505;6506.902396463962;9697.806043879224;10135.493225338556;10294.330868493524;10302.639407620996;10367.688969330931;10226.437545935045;10410.47947602632;10421.218408619536;10469.424181670081;10477.42374169428;7114.288571142844;7570.205128461653;7675.155732869492;7857.135715071452;8032.3975701823765;8649.264812491008;8813.515256660945;8833.955830220808;8848.601812918305;8850.070742571937;7459.552426854406;7616.885746713693;7672.271134242238;7684.568104160939;7943.920560794318;7255.020572222682;7286.96356518214;7314.268573142643;7466.440016998856;7518.699252029857;7097.609631470112;7289.635518224173;7298.598577078099;7302.415806735342;7324.487285889936;5182.740862956913;5216.869578260574;5223.712695801615;5325.973370133124;5477.260569823023;5156.381234251914;5260.158374660036;5294.258803767552;5339.092354299701;5495.6153069284765 05:42:48 INFO - PROCESS | 23177 | |4;prototype.html;326.7761583315429;332.95784195468184;334.29964224948725;338.8018009464463;345.16297977404787;5357.589084911786;5393.9212157568545;5577.609567330289;5584.832455026346;5600.019996500611;5402.78388864445;5482.91775623366;5484.61607687461;5505.229267902497;5509.917351239735;4256.787160641963;4338.197433474801;4347.673924455663;4359.651227901776;4363.127374525092;4173.290540608089;4312.202242585132;4322.157179350028;4357.716748411359;4377.489766030714;4292.59220374064;4296.033392486696;4312.374705667692;4314.266574682296;4325.243082460573;4310.374995625648;4316.762578058221;4320.438343015419;4333.06839029607;4340.826366945318;3511.157322242669;3838.155605766755;3859.6912247020173;3859.7298189126773;3873.9418908716393;5277.255826969992;5288.576913846883;5303.178007408857;5311.389190243133;5323.600729945231;4808.735519546423;4852.053849499349;4853.4418541867435;4873.853784386474;4895.559399654013;5471.316085489314;5673.943260567383;5681.403452637496;5699.860027994418;5706.172604972256;4074.246264441088;4098.766172436;4099.795010249505;4104.240715467618;4122.855700050483;5980.28236611605;6005.3394126646035;6006.975326531235;6010.158577799068;6026.668533230671;4092.1406504633765;4168.562300958416;4241.660667146621;4246.426732391149;4259.574042595716;4245.23585754561;4254.29804082323;4257.680673949404;4260.403543503912;4281.293586558245;4874.341963834908;4912.214045752662;4915.5330243626795;4924.9507504925205;4947.25791131326;5682.7442765075675;5799.3040835100055;5858.209141765892;5863.648181109147;5889.146073819358;1450.833154187282;1467.156385078584;1472.4110355857529;1474.9527835236888;1484.346887369554;900.7522931193843;924.778053267211;938.5025936253796;942.1614762861059;943.8820147481565;4879.754962949599;4919.754012299442;4923.556879880828;4933.506649335038;4944.159492886146;5135.794568217304;5158.890838469747;5254.950569277985;5257.947420525822;5326.9467305327225;4602.493725690171;4920.335754673145;4921.827736029221;4950.737561921687;4976.651634385558;2757.7793776497833;2767.363506393541;2778.4304217635336;2781.707920668341;2793.69269380368;5442.782288708408;5455.645383050169;5475.5072043516275;5475.561955043587;5539.806106786243;5114.71869047206;5264.263003179558;5300.416954135042;5346.198070289488;5352.464753524617;5417.83746487606;5423.349198096174;5437.8368648940595;5444.618876678674;5458.536024437967;5246.3704355477585;5253.789848406021;5276.920846187233;5322.760475778522;5342.545883599782;4680.836170734008;5095.617828662791;5109.437961824122;5110.437851836369;5167.431582525995;5422.295101636762;5427.371788463524;5475.370332411664;5475.988206486496;5529.917051244315;3889.7277190596387;3985.740926839746;4067.1255680028935;4092.6112019358116;4141.461609990682;5846.883062338644;5858.2677165354335;5862.824115276549;5871.91369596626;5877.735501902339;5577.768892443055;5672.858178545569;5746.712664366849;5785.177669034409;5823.5923485355615;5626.271258439735;5628.74670639814;5633.436656334334;5670.829875103754;5703.258576385043;5651.237082993744;5680.11958146488;5721.570882183936;5721.599488035798;5726.370099288992;5467.808626698046;5684.232628595087;5745.712714364348;5761.423857614205;5809.170111414891;5525.336959564878;5568.693721845338;5605.467480589337;5663.631863928831;5697.943020569907 05:42:48 INFO - PROCESS | 23177 | |5;yui.html;738.5236522443024;756.1926994483186;785.414865924886;838.9958050209748;845.51382954801;14641;15126.168060756654;15128;15264.847351526496;15350.769738453931;14823.703525929475;14825.110493370405;14888.553343399688;14972.700545989073;14992.625184370396;653.7483069018439;773.9458237923347;784.2118670735903;805.0379796143582;807.8949736534242;821.2690705272313;823.4853216739538;825.2531459029558;829.498153617062;829.929455996241;870.0690261420283;874.2437791310502;878.7363790862747;879.9692010779625;882.6822343956171;861.2291998661194;863.4258218284833;867.4578388507183;870.4777133719781;874.4010352908215;638.6136387485598;639.4181295021555;640.4716109209874;640.8782331357028;640.8814369341686;13165.539206127836;13168.73662526744;13189.934050329783;13217.14088584239;13254.867451325556;15083.698326033418;15532.61168470786;15558.9222053889;15697.136657483834;15982.360705571764;12357.38213089351;12510.874891251062;12548.058895582868;12567.622971310875;12594.496220151183;3852.5184351956004;3906.277338692351;3926.6466018058227;4042.595740425934;4044.5146582410007;67348.32651673518;70150.64924675395;70394.29605703929;81402.59298703469;81567;12016.519339226508;12022.338771367484;12081.818772718416;12172.208806427554;12402.689932751753;21240.681389779165;21273.149074036864;21288.25491107804;21322.78677213239;21368.679469807965;8187.918120818835;8571;8667.653293868301;9016.459012459274;9241.861372079424;4526.547345265447;4663.603593694506;4735.502772208937;4772.522747725269;4837.540433658797;3379.85085071077;3511.94732079019;3541.628129046413;3552.307300076512;3567.554055743032;596.5853731656457;597.8087012156068;599.1043390131781;603.6197195766727;622.411820829321;627.8210709947643;644.3331152257391;683.5317807302014;692.1797669761349;696.4324075878143;8669.26311263537;9107.635694572275;9225.308101892386;9574.664886728931;9721.319507634538;651.3519048546632;658.7562601837255;677.9220389655154;684.4524380495584;689.4622194688151;4416.712913660602;4728.38530990969;4734.337192793012;4742.810287588527;4852.902941941212;87062;127183.09225361627;127805;131794;131919;110924;111623;112450.43774781073;112590;113185.43407283076;96182;96868;98993.50503247438;99335.50332248436;101076.49461752939;8614.827703445771;8947.116152740033;8951.41815781972;8984.416012959136;9051.411658242194;51462.48537514727;55030.44969550413;56366;57460.1380979294;57513.13730293965;79282.6035869817;85251.57374213089;85612.57193713992;87314;90103;11300;11558.479868405773;11560.710982225512;11834.881651183377;11892.048636109264;13192.736145277233;13409.731805363643;13415.262160581262;13428.19430834153;14041.1575305482;12565.560205392767;13330.800037999632;13383.39774710121;13384.665383365495;13397.933010334886;11653.883461165618;12236.327002014974;12299.323537205539;12695.682607934876;12940.741185176432;11878.109141814572;12372.752544949231;12435.129540932048;12700.428480718574;12730.618081457571;9602.711918642452;9664.613415463584;9938;9949.751256218653;10018.448985305879;8381.413301068867;9430.95284523573;10118.342307749972;10456.215783816093;10628.84056739134 05:42:48 INFO - PROCESS | 23177 | __end_tp_report 05:42:48 INFO - PROCESS | 23177 | __start_cc_report 05:42:48 INFO - PROCESS | 23177 | _x_x_mozilla_cycle_collect,329 05:42:48 INFO - PROCESS | 23177 | __end_cc_report 05:42:48 INFO - PROCESS | 23177 | __startTimestamp1470746568527__endTimestamp 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | ------- Summary: start ------- 05:42:48 INFO - PROCESS | 23177 | Number of tests: 6 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | [#0] dojo.html Cycles:165 Average:5313.77 Median:5534.50 stddev:711.66 (12.9%) stddev-sans-first:690.78 05:42:48 INFO - PROCESS | 23177 | Values: 3023.1 3032.2 3059.0 3060.3 3061.8 5218.5 5249.9 5271.3 5284.1 5315.7 5335.3 5366.6 5391.2 5402.6 5424.3 4820.7 4878.3 4891.8 4934.2 4976.5 4929.3 5001.5 5053.1 5054.1 5054.2 564.7 4830.9 5024.5 5058.0 5068.9 4860.1 4891.6 4910.5 4956.8 4964.5 4828.4 4845.5 4865.3 4868.1 4892.0 5168.0 5261.1 5268.3 5308.8 5320.2 5696.0 5732.8 5739.5 5781.4 5792.4 5764.5 5769.5 5779.6 5821.6 5829.0 5259.7 5354.0 5415.9 5421.9 5422.8 5894.9 5903.9 5954.0 6019.6 6058.2 5686.6 5717.1 5718.5 5735.4 5739.5 5368.9 5776.5 5785.3 5794.9 5819.3 5708.3 5738.3 5769.3 5775.5 5858.3 5726.0 5756.8 5762.0 5799.4 5822.0 4320.4 4475.1 4495.0 4506.8 4521.0 3896.6 3931.6 3942.4 3956.8 3976.0 5498.8 5505.1 5529.2 5529.8 5573.9 5567.3 5674.1 5831.7 5844.6 5865.4 5366.3 5394.0 5411.9 5463.5 5469.2 4896.2 4904.4 4918.4 4922.3 4929.5 5807.6 5907.1 5925.2 5960.6 5968.5 5685.4 5775.5 5783.2 5801.4 5829.1 5881.0 5946.2 5949.4 5953.6 5984.5 5365.6 5521.4 5597.3 5610.2 5644.8 5612.3 5707.3 5740.7 5741.9 5781.3 5511.1 5520.7 5550.2 5564.5 5603.7 5402.7 5538.7 5548.9 5561.1 5562.9 5577.2 5577.6 5629.8 5646.1 5670.9 5534.5 5650.2 5660.3 5675.2 5715.7 5311.1 5367.5 5504.8 5583.8 5590.1 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | [#1] ext.html Cycles:180 Average:61705.87 Median:42785.18 stddev:120102.37 (280.7%) stddev-sans-first:120351.51 05:42:48 INFO - PROCESS | 23177 | Values: 548.0 579.4 586.9 592.9 627.9 39402.4 44118.6 44162.6 44268.8 44403.8 44318.8 44498.8 44505.0 44545.0 44592.3 8881.6 8898.5 8942.4 8962.0 8992.1 8940.3 9012.3 9027.9 9045.6 9098.3 9077.5 9097.1 9100.1 9131.2 9165.1 8975.4 8982.9 9035.4 9046.5 9084.7 8823.3 8897.6 8930.9 8958.1 8977.6 42405.0 42476.7 42660.4 42690.4 42778.6 3531.8 3744.2 3768.1 3796.7 3862.9 33467.5 33827.0 34014.7 34048.5 34099.1 3976.1 4085.6 4114.1 4177.6 4219.7 355356.0 360765.0 361828.0 362920.0 363400.0 60394.7 60412.4 60503.4 60789.7 60875.0 64410.0 64972.4 65086.3 65486.8 65618.7 16215.1 16293.8 16308.8 16420.0 16433.5 11774.4 11861.8 11873.8 11898.5 11908.2 17146.7 17600.9 17730.7 17768.4 18072.1 5980.4 6012.4 6060.7 6064.3 6107.4 959.8 1063.5 1105.6 1169.6 1213.5 33399.3 33808.5 34044.3 34123.3 34516.7 1034.3 1118.2 1199.8 1247.0 1255.8 17040.7 17188.3 17286.7 17342.9 17528.4 527140.0 533493.0 535415.0 535726.0 535873.0 61466.4 61520.4 61667.4 61686.7 62106.0 1336.5 1354.5 1385.9 1388.3 1389.3 31377.5 32163.5 32553.3 32654.7 32833.7 52025.2 52027.0 52073.2 52100.0 52296.0 447679.0 448980.0 449204.0 450417.0 451005.0 28973.0 29601.4 29813.8 42936.4 43227.1 49928.8 50140.5 50313.5 51078.7 52224.2 41843.8 42600.0 42682.6 42791.8 43888.8 41725.6 41918.0 42220.0 43002.6 43380.8 42334.8 42421.0 43292.4 43423.1 43735.8 36570.6 37543.8 38285.2 38369.2 38797.4 29130.0 29330.4 29430.4 29490.6 29696.7 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | [#2] jquery.html Cycles:180 Average:27490.03 Median:23870.46 stddev:72966.45 (305.7%) stddev-sans-first:73142.75 05:42:48 INFO - PROCESS | 23177 | Values: 380.1 381.4 394.7 397.9 422.4 13945.3 18435.0 19287.2 19775.5 19950.4 18990.6 19045.8 19402.9 19719.7 19726.0 5717.9 5911.4 5953.4 5966.3 6062.0 5789.8 5883.2 5898.4 5929.3 5940.3 5748.3 5803.9 5894.2 5921.0 5931.0 5787.9 5882.1 5912.7 5916.6 5924.1 5014.5 5187.6 5219.2 5231.9 5243.2 22784.8 23386.9 23480.5 23820.3 23920.6 2361.7 2525.8 2672.0 2928.6 3169.4 14374.2 14963.3 15069.9 15092.8 15523.2 1978.6 2007.3 2033.4 2038.7 2041.3 82498.6 83266.6 84810.0 85962.6 86079.6 10425.5 10463.2 10644.1 10754.9 10966.3 14687.5 14746.7 14788.1 14852.1 14875.3 7802.2 8080.8 8181.3 8262.9 8326.2 7606.8 7741.8 7819.3 7952.9 8014.4 6454.4 6550.5 6593.2 6667.3 6780.6 1925.9 1951.3 1967.2 2014.7 2016.6 930.2 990.0 1089.8 1108.6 1130.9 19932.7 20148.7 20329.4 20431.8 20469.2 1016.3 1036.2 1048.0 1066.3 1087.7 10903.9 11650.7 11683.0 11696.4 11707.6 433078.0 442074.0 444305.0 445304.0 448978.0 49321.8 52033.7 80750.6 80928.0 83647.6 997.8 1017.6 1031.5 1033.4 1036.5 16984.7 17582.5 18244.4 18386.3 18658.2 27633.0 34169.5 34732.7 41514.4 42070.6 64015.0 64959.0 65150.0 66363.3 66914.7 8538.4 8545.9 8767.3 8842.0 8985.8 12816.0 13425.7 13426.5 13540.8 13745.9 11836.8 11878.8 12039.7 12104.6 12373.8 11333.7 11810.2 12021.4 12209.3 12475.9 12245.1 12515.9 12595.8 12601.7 12671.8 8542.9 8723.2 8724.4 8955.6 9037.1 8475.6 11286.7 11972.6 11973.4 12161.6 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | [#3] mootools.html Cycles:180 Average:5891.90 Median:466.61 stddev:3358.61 (719.8%) stddev-sans-first:3351.75 05:42:48 INFO - PROCESS | 23177 | Values: 1490.7 1507.5 1641.4 1803.1 1803.9 7930.6 8531.6 8699.0 9295.5 9318.1 8740.5 9018.8 9060.0 9106.4 9125.1 2319.8 2365.2 2369.1 2369.4 2395.7 2363.6 2367.5 2430.1 2431.2 2439.5 2370.3 2394.1 2394.3 2433.6 2441.7 2326.6 2341.2 2352.8 2355.6 2406.3 2312.8 2317.5 2317.6 2319.7 2335.6 8945.2 8946.9 9042.6 9053.7 9074.3 5343.4 5413.6 5428.3 5438.6 5510.3 3351.7 3358.8 3385.4 3410.6 3429.5 1186.8 1198.1 1200.5 1208.7 1224.0 12253.1 12347.3 12348.4 12438.7 12467.0 4443.5 4689.7 4779.5 4792.9 4821.2 10467.4 10530.2 10531.4 10549.3 10574.8 5393.7 5408.4 5435.6 5441.2 5447.4 4387.3 4786.1 4877.3 4951.3 4959.8 3801.3 4051.6 4060.1 4130.0 4135.1 1251.6 1265.0 1268.5 1289.7 1315.2 968.4 980.1 994.8 1010.3 1015.0 6040.6 6049.9 6098.5 6146.9 6150.8 455.3 456.5 466.5 466.7 467.7 4196.8 4257.5 4328.4 4335.2 4447.1 10777.4 11289.5 11305.6 11318.4 11334.4 11166.7 11213.9 11215.6 11221.0 11230.6 7792.7 8131.1 8141.0 8303.2 8451.0 6155.6 6243.3 6278.2 6396.0 6506.9 9697.8 10135.5 10294.3 10302.6 10367.7 10226.4 10410.5 10421.2 10469.4 10477.4 7114.3 7570.2 7675.2 7857.1 8032.4 8649.3 8813.5 8834.0 8848.6 8850.1 7459.6 7616.9 7672.3 7684.6 7943.9 7255.0 7287.0 7314.3 7466.4 7518.7 7097.6 7289.6 7298.6 7302.4 7324.5 5182.7 5216.9 5223.7 5326.0 5477.3 5156.4 5260.2 5294.3 5339.1 5495.6 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | [#4] prototype.html Cycles:180 Average:4664.89 Median:5256.45 stddev:1344.42 (25.6%) stddev-sans-first:1308.17 05:42:48 INFO - PROCESS | 23177 | Values: 326.8 333.0 334.3 338.8 345.2 5357.6 5393.9 5577.6 5584.8 5600.0 5402.8 5482.9 5484.6 5505.2 5509.9 4256.8 4338.2 4347.7 4359.7 4363.1 4173.3 4312.2 4322.2 4357.7 4377.5 4292.6 4296.0 4312.4 4314.3 4325.2 4310.4 4316.8 4320.4 4333.1 4340.8 3511.2 3838.2 3859.7 3859.7 3873.9 5277.3 5288.6 5303.2 5311.4 5323.6 4808.7 4852.1 4853.4 4873.9 4895.6 5471.3 5673.9 5681.4 5699.9 5706.2 4074.2 4098.8 4099.8 4104.2 4122.9 5980.3 6005.3 6007.0 6010.2 6026.7 4092.1 4168.6 4241.7 4246.4 4259.6 4245.2 4254.3 4257.7 4260.4 4281.3 4874.3 4912.2 4915.5 4925.0 4947.3 5682.7 5799.3 5858.2 5863.6 5889.1 1450.8 1467.2 1472.4 1475.0 1484.3 900.8 924.8 938.5 942.2 943.9 4879.8 4919.8 4923.6 4933.5 4944.2 5135.8 5158.9 5255.0 5257.9 5326.9 4602.5 4920.3 4921.8 4950.7 4976.7 2757.8 2767.4 2778.4 2781.7 2793.7 5442.8 5455.6 5475.5 5475.6 5539.8 5114.7 5264.3 5300.4 5346.2 5352.5 5417.8 5423.3 5437.8 5444.6 5458.5 5246.4 5253.8 5276.9 5322.8 5342.5 4680.8 5095.6 5109.4 5110.4 5167.4 5422.3 5427.4 5475.4 5476.0 5529.9 3889.7 3985.7 4067.1 4092.6 4141.5 5846.9 5858.3 5862.8 5871.9 5877.7 5577.8 5672.9 5746.7 5785.2 5823.6 5626.3 5628.7 5633.4 5670.8 5703.3 5651.2 5680.1 5721.6 5721.6 5726.4 5467.8 5684.2 5745.7 5761.4 5809.2 5525.3 5568.7 5605.5 5663.6 5697.9 05:42:48 INFO - PROCESS | 23177 | 05:42:48 INFO - PROCESS | 23177 | [#5] yui.html Cycles:180 Average:21806.37 Median:4757.67 stddev:33018.37 (694.0%) stddev-sans-first:33073.10 05:42:48 INFO - PROCESS | 23177 | Values: 738.5 756.2 785.4 839.0 845.5 14641.0 15126.2 15128.0 15264.8 15350.8 14823.7 14825.1 14888.6 14972.7 14992.6 653.7 773.9 784.2 805.0 807.9 821.3 823.5 825.3 829.5 829.9 870.1 874.2 878.7 880.0 882.7 861.2 863.4 867.5 870.5 874.4 638.6 639.4 640.5 640.9 640.9 13165.5 13168.7 13189.9 13217.1 13254.9 15083.7 15532.6 15558.9 15697.1 15982.4 12357.4 12510.9 12548.1 12567.6 12594.5 3852.5 3906.3 3926.6 4042.6 4044.5 67348.3 70150.6 70394.3 81402.6 81567.0 12016.5 12022.3 12081.8 12172.2 12402.7 21240.7 21273.1 21288.3 21322.8 21368.7 8187.9 8571.0 8667.7 9016.5 9241.9 4526.5 4663.6 4735.5 4772.5 4837.5 3379.9 3511.9 3541.6 3552.3 3567.6 596.6 597.8 599.1 603.6 622.4 627.8 644.3 683.5 692.2 696.4 8669.3 9107.6 9225.3 9574.7 9721.3 651.4 658.8 677.9 684.5 689.5 4416.7 4728.4 4734.3 4742.8 4852.9 87062.0 127183.1 127805.0 131794.0 131919.0 110924.0 111623.0 112450.4 112590.0 113185.4 96182.0 96868.0 98993.5 99335.5 101076.5 8614.8 8947.1 8951.4 8984.4 9051.4 51462.5 55030.4 56366.0 57460.1 57513.1 79282.6 85251.6 85612.6 87314.0 90103.0 11300.0 11558.5 11560.7 11834.9 11892.0 13192.7 13409.7 13415.3 13428.2 14041.2 12565.6 13330.8 13383.4 13384.7 13397.9 11653.9 12236.3 12299.3 12695.7 12940.7 11878.1 12372.8 12435.1 12700.4 12730.6 9602.7 9664.6 9938.0 9949.8 10018.4 8381.4 9431.0 10118.3 10456.2 10628.8 05:42:48 INFO - PROCESS | 23177 | -------- Summary: end -------- 05:42:48 INFO - PROCESS | 23177 | 05:42:49 INFO - TEST-INFO | 23177: exit 0 05:42:49 INFO - TEST-OK | dromaeo_css | took 1111418ms 05:42:49 INFO - TEST-START | kraken 05:42:49 INFO - operating with platform_type : linux_ 05:42:49 INFO - Initialising browser for kraken test... 05:42:49 INFO - TEST-INFO | started process 23423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptyxiJd/profile http://localhost:48448/getInfo.html) 05:42:53 INFO - PROCESS | 23423 | __metrics Screen width/height:1600/1200 05:42:53 INFO - PROCESS | 23423 | colorDepth:24 05:42:53 INFO - PROCESS | 23423 | Browser inner width/height: 1024/697 05:42:53 INFO - PROCESS | 23423 | __metrics 05:42:53 ERROR - PROCESS | 23423 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:42:54 INFO - TEST-INFO | 23423: exit 0 05:42:54 INFO - Browser initialized. 05:42:54 INFO - Running cycle 1/1 for kraken test... 05:42:54 INFO - TEST-INFO | started process 23544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptyxiJd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:06 INFO - PROCESS | 23544 | RSS: Main: 163958784 05:43:06 INFO - PROCESS | 23544 | 05:43:08 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48448/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:09 INFO - PROCESS | 23544 | RSS: Main: 169558016 05:43:09 INFO - PROCESS | 23544 | 05:43:12 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48448/tests/kraken/driver.html?testName=audio-dft) 05:43:13 INFO - PROCESS | 23544 | RSS: Main: 167886848 05:43:13 INFO - PROCESS | 23544 | 05:43:15 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48448/tests/kraken/driver.html?testName=audio-fft) 05:43:16 INFO - PROCESS | 23544 | RSS: Main: 164126720 05:43:16 INFO - PROCESS | 23544 | 05:43:18 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48448/tests/kraken/driver.html?testName=audio-oscillator) 05:43:19 INFO - PROCESS | 23544 | RSS: Main: 165171200 05:43:19 INFO - PROCESS | 23544 | 05:43:21 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:22 INFO - PROCESS | 23544 | RSS: Main: 165433344 05:43:22 INFO - PROCESS | 23544 | 05:43:25 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48448/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:25 INFO - PROCESS | 23544 | RSS: Main: 165801984 05:43:25 INFO - PROCESS | 23544 | 05:43:29 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48448/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:29 INFO - PROCESS | 23544 | RSS: Main: 163659776 05:43:29 INFO - PROCESS | 23544 | 05:43:32 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48448/tests/kraken/driver.html?testName=json-parse-financial) 05:43:33 INFO - PROCESS | 23544 | RSS: Main: 164978688 05:43:33 INFO - PROCESS | 23544 | 05:43:34 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:35 INFO - PROCESS | 23544 | RSS: Main: 165208064 05:43:35 INFO - PROCESS | 23544 | 05:43:37 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:38 INFO - PROCESS | 23544 | RSS: Main: 164929536 05:43:38 INFO - PROCESS | 23544 | 05:43:40 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:40 INFO - PROCESS | 23544 | RSS: Main: 166342656 05:43:40 INFO - PROCESS | 23544 | 05:43:43 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:43 INFO - PROCESS | 23544 | RSS: Main: 166207488 05:43:43 INFO - PROCESS | 23544 | 05:43:46 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:47 INFO - PROCESS | 23544 | RSS: Main: 165806080 05:43:47 INFO - PROCESS | 23544 | 05:43:48 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:48448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48448/tests/kraken/driver.html?testName=ai-astar) 05:43:49 INFO - PROCESS | 23544 | RSS: Main: 167161856 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | __start_tp_report 05:43:49 INFO - PROCESS | 23544 | _x_x_mozilla_page_load 05:43:49 INFO - PROCESS | 23544 | _x_x_mozilla_page_load_details 05:43:49 INFO - PROCESS | 23544 | |i|pagename|runs| 05:43:49 INFO - PROCESS | 23544 | |0;ai-astar;103;116;108;112;115;113;113;114;113;112 05:43:49 INFO - PROCESS | 23544 | |1;audio-beat-detection;157;119;148;176;120;149;149;122;185;124 05:43:49 INFO - PROCESS | 23544 | |2;audio-dft;165;164;162;163;163;172;166;163;163;165 05:43:49 INFO - PROCESS | 23544 | |3;audio-fft;76;75;77;180;77;76;76;76;167;77 05:43:49 INFO - PROCESS | 23544 | |4;audio-oscillator;85;85;146;85;85;86;156;84;85;141 05:43:49 INFO - PROCESS | 23544 | |5;imaging-gaussian-blur;118;118;118;119;119;119;118;118;118;119 05:43:49 INFO - PROCESS | 23544 | |6;imaging-darkroom;148;149;150;149;147;150;147;148;148;148 05:43:49 INFO - PROCESS | 23544 | |7;imaging-desaturate;99;97;95;96;100;96;97;96;96;97 05:43:49 INFO - PROCESS | 23544 | |8;json-parse-financial;58;57;52;52;53;55;53;52;52;55 05:43:49 INFO - PROCESS | 23544 | |9;json-stringify-tinderbox;60;61;61;60;64;59;59;60;60;60 05:43:49 INFO - PROCESS | 23544 | |10;stanford-crypto-aes;77;76;77;76;77;74;78;81;81;75 05:43:49 INFO - PROCESS | 23544 | |11;stanford-crypto-ccm;135;121;123;122;125;125;129;124;144;124 05:43:49 INFO - PROCESS | 23544 | |12;stanford-crypto-pbkdf2;165;164;161;162;158;158;157;163;158;159 05:43:49 INFO - PROCESS | 23544 | |13;stanford-crypto-sha256-iterative;67;68;66;64;63;64;64;64;64;66 05:43:49 INFO - PROCESS | 23544 | __end_tp_report 05:43:49 INFO - PROCESS | 23544 | __start_cc_report 05:43:49 INFO - PROCESS | 23544 | _x_x_mozilla_cycle_collect,849 05:43:49 INFO - PROCESS | 23544 | __end_cc_report 05:43:49 INFO - PROCESS | 23544 | __startTimestamp1470746629231__endTimestamp 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | ------- Summary: start ------- 05:43:49 INFO - PROCESS | 23544 | Number of tests: 14 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:2.26 05:43:49 INFO - PROCESS | 23544 | Values: 103.0 116.0 108.0 112.0 115.0 113.0 113.0 114.0 113.0 112.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:149.00 stddev:23.61 (15.8%) stddev-sans-first:24.63 05:43:49 INFO - PROCESS | 23544 | Values: 157.0 119.0 148.0 176.0 120.0 149.0 149.0 122.0 185.0 124.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.88 (1.7%) stddev-sans-first:3.05 05:43:49 INFO - PROCESS | 23544 | Values: 165.0 164.0 162.0 163.0 163.0 172.0 166.0 163.0 163.0 165.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:41.12 (54.1%) stddev-sans-first:43.00 05:43:49 INFO - PROCESS | 23544 | Values: 76.0 75.0 77.0 180.0 77.0 76.0 76.0 76.0 167.0 77.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:85.00 stddev:30.49 (35.9%) stddev-sans-first:31.57 05:43:49 INFO - PROCESS | 23544 | Values: 85.0 85.0 146.0 85.0 85.0 86.0 156.0 84.0 85.0 141.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:43:49 INFO - PROCESS | 23544 | Values: 118.0 118.0 118.0 119.0 119.0 119.0 118.0 118.0 118.0 119.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 05:43:49 INFO - PROCESS | 23544 | Values: 148.0 149.0 150.0 149.0 147.0 150.0 147.0 148.0 148.0 148.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.50 stddev:1.52 (1.6%) stddev-sans-first:1.41 05:43:49 INFO - PROCESS | 23544 | Values: 99.0 97.0 95.0 96.0 100.0 96.0 97.0 96.0 96.0 97.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:2.23 (4.1%) stddev-sans-first:1.81 05:43:49 INFO - PROCESS | 23544 | Values: 58.0 57.0 52.0 52.0 53.0 55.0 53.0 52.0 52.0 55.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:1.51 05:43:49 INFO - PROCESS | 23544 | Values: 60.0 61.0 61.0 60.0 64.0 59.0 59.0 60.0 60.0 60.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:2.30 (3.0%) stddev-sans-first:2.44 05:43:49 INFO - PROCESS | 23544 | Values: 77.0 76.0 77.0 76.0 77.0 74.0 78.0 81.0 81.0 75.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:125.00 stddev:7.15 (5.7%) stddev-sans-first:7.00 05:43:49 INFO - PROCESS | 23544 | Values: 135.0 121.0 123.0 122.0 125.0 125.0 129.0 124.0 144.0 124.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:2.88 (1.8%) stddev-sans-first:2.55 05:43:49 INFO - PROCESS | 23544 | Values: 165.0 164.0 161.0 162.0 158.0 158.0 157.0 163.0 158.0 159.0 05:43:49 INFO - PROCESS | 23544 | 05:43:49 INFO - PROCESS | 23544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.63 (2.5%) stddev-sans-first:1.56 05:43:49 INFO - PROCESS | 23544 | Values: 67.0 68.0 66.0 64.0 63.0 64.0 64.0 64.0 64.0 66.0 05:43:49 INFO - PROCESS | 23544 | -------- Summary: end -------- 05:43:49 INFO - PROCESS | 23544 | 05:43:50 INFO - TEST-INFO | 23544: exit 0 05:43:50 INFO - TEST-OK | kraken | took 61042ms 05:43:50 INFO - SUITE-END | took 1172s 05:43:50 INFO - Completed test suite (00:19:32) 05:43:50 INFO - javascript benchmark 05:43:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7297.191083580785, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3023.123294244669, 3032.2116249775054, 3059.0211132437616, 3060.2502386915207, 3061.8162910225383, 5218.478152184784, 5249.8950020999555, 5271.288376069229, 5284.101702710539, 5315.654482458643, 5335.279737235472, 5366.597505187116, 5391.245225668409, 5402.621816472849, 5424.267723857278, 4820.662553621248, 4878.341423907763, 4891.779869905863, 4934.235193544989, 4976.502349765013, 4929.2606109083745, 5001.474845141262, 5053.065182941149, 5054.090263752523, 5054.21659642756, 564.6871686108163, 4830.903381932377, 5024.547790698854, 5058.013687330972, 5068.949310506885, 4860.1008813369635, 4891.608671306287, 4910.459849416561, 4956.776945037482, 4964.478729733362, 4828.444728856191, 4845.466998630148, 4865.34317867087, 4868.099401610678, 4891.9755401222765, 5168.0, 5261.1319132343115, 5268.315119034501, 5308.814191503279, 5320.201969704536, 5696.0, 5732.799352022701, 5739.454751798572, 5781.364049954502, 5792.4497172768515, 5764.51001664859, 5769.451902069297, 5779.624324418942, 5821.563382746311, 5829.0, 5259.710715910662, 5353.973230133864, 5415.945840541623, 5421.891562168735, 5422.810201642924, 5894.938910996062, 5903.911441328383, 5954.047352423591, 6019.638821670714, 6058.182145410401, 5686.630369026083, 5717.085266357446, 5718.485336319751, 5735.426457354315, 5739.512141467939, 5368.946310536923, 5776.480116789509, 5785.334686511021, 5794.942050579524, 5819.301683797971, 5708.257926469532, 5738.311402631711, 5769.336526299446, 5775.480206781326, 5858.297004359419, 5726.0, 5756.7910738744495, 5762.049261871828, 5799.3620701722775, 5822.039363505059, 4320.3519472078815, 4475.127350166751, 4495.0, 4506.842260520866, 4520.977395113004, 3896.5518965318784, 3931.6461518463475, 3942.40863870416, 3956.762594244297, 3975.9662487753394, 5498.780048798083, 5505.146702261156, 5529.198266251371, 5529.751161197756, 5573.860653483695, 5567.3040869891265, 5674.092145256739, 5831.679257640785, 5844.649321040666, 5865.4134586541, 5366.302380690485, 5393.9730301348245, 5411.918821217685, 5463.535599474009, 5469.179623056494, 4896.216605343128, 4904.411470623477, 4918.360613120271, 4922.261660750844, 4929.457759646436, 5807.5644326675665, 5907.084401917709, 5925.200097986716, 5960.612560183574, 5968.4926781224085, 5685.374608792947, 5775.451332123442, 5783.19035335045, 5801.419858014165, 5829.125631155361, 5881.0, 5946.1972633693895, 5949.375315591974, 5953.583249172516, 5984.521238300838, 5365.570754339721, 5521.365043020104, 5597.3003374578175, 5610.158476228598, 5644.8306550803545, 5612.298462692163, 5707.286589176353, 5740.712964351682, 5741.885162296814, 5781.32341620942, 5511.063119269814, 5520.66875987442, 5550.167474878801, 5564.527015203591, 5603.663780173039, 5402.729863506887, 5538.723063846711, 5548.861278467909, 5561.138023606348, 5562.888742225214, 5577.163425486209, 5577.553795696415, 5629.802956896489, 5646.0683987141665, 5670.858228544319, 5534.501894829485, 5650.208970744017, 5660.29246344207, 5675.177099320658, 5715.742791574306, 5311.070562651597, 5367.463253674758, 5504.80733174353, 5583.832485025456, 5590.077637189981], "value": 5267.990110795177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.0132221982134, 579.4090028171265, 586.9471747542723, 592.8577141486044, 627.852454673152, 39402.408963865564, 44118.55881441181, 44162.55837441624, 44268.77865610671, 44403.77798111005, 44318.77840610792, 44498.77750611251, 44505.0, 44545.0, 44592.3311150333, 8881.64473421064, 8898.510581917992, 8942.41874278173, 8961.95519022404, 8992.145746154138, 8940.329475289347, 9012.27901767857, 9027.864582031274, 9045.59294831731, 9098.31762617803, 9077.455352678828, 9097.135772101672, 9100.089991000914, 9131.178193962542, 9165.129312715282, 8975.371723979324, 8982.910170898273, 9035.412698174598, 9046.547672616343, 9084.68203612877, 8823.338249631239, 8897.644094236222, 8930.86603700945, 8958.104189581056, 8977.596008179647, 42405.0, 42476.663783491895, 42660.3600945986, 42690.359644605356, 42778.57221427808, 3531.7704349217474, 3744.157564547982, 3768.0768211788286, 3796.7152463565344, 3862.9034274143373, 33467.49798753021, 33827.0, 34014.6598534014, 34048.48927266093, 34099.14752131192, 3976.1451287973223, 4085.5710150434074, 4114.074333275019, 4177.561356057631, 4219.7046206765535, 355356.0, 360765.0, 361827.9999999974, 362919.96640268713, 363400.0, 60394.698026510465, 60412.375257484695, 60503.394966050655, 60789.69605151946, 60875.0, 64410.0, 64972.35027649663, 65086.34913650898, 65486.83184354194, 65618.67190664016, 16215.108169050816, 16293.837061629469, 16308.75536866948, 16420.0, 16433.506994790176, 11774.411279436164, 11861.822072668916, 11873.762524749456, 11898.46456909441, 11908.166428349932, 17146.742798858028, 17600.911995440198, 17730.734038989427, 17768.378106766202, 18072.09639518019, 5980.401959803985, 6012.398760123952, 6060.727267272983, 6064.332923378425, 6107.358727333655, 959.7792507723262, 1063.4523220541273, 1105.5964572930984, 1169.5555688838188, 1213.4660749270292, 33399.33201336008, 33808.492872606934, 34044.31911361808, 34123.31753364919, 34516.654833451845, 1034.255336157965, 1118.189312748251, 1199.8140288255333, 1246.975060498803, 1255.7990721484518, 17040.659186816196, 17188.31246750116, 17286.740698889527, 17342.913285433493, 17528.386506472467, 527140.0, 533493.0, 535415.0, 535726.0, 535873.0, 61466.385336146064, 61520.384796152364, 61667.383326166164, 61686.69156654188, 62106.0, 1336.5388940815403, 1354.5191457032809, 1385.902986790915, 1388.2919710947288, 1389.2845184729872, 31377.529337059506, 32163.51754723634, 32553.348933020734, 32654.673453265164, 32833.671663283065, 52025.21962170495, 52027.0, 52073.21890171574, 52099.99999999849, 52296.0, 447679.0, 448980.0, 449204.0, 450417.0, 451005.0, 28973.0, 29601.407971840872, 29813.763967702944, 42936.35595466133, 43227.135457290045, 49928.75035624798, 50140.49859501358, 50313.49686503088, 51078.744606276734, 52224.21663674972, 41843.7907810459, 42600.0, 42682.57317426786, 42791.786041069594, 43888.780556097016, 41725.58274417217, 41918.0, 42220.0, 43002.569974299855, 43380.78309608432, 42334.78832605817, 42421.0, 43292.35061474144, 43423.13153736844, 43735.781321094466, 36570.63429365672, 37543.81228093842, 38285.23429531338, 38369.2326153481, 38797.41803873001, 29130.0, 29330.413391731618, 29430.411391771617, 29490.557641635824, 29696.703032969395], "value": 20527.90847385903, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.08778930566655, 381.3688345787719, 394.6980559871699, 397.912459258963, 422.4255013182072, 13945.302734863268, 18435.0, 19287.22851085955, 19775.50561235968, 19950.401487955365, 18990.62018759624, 19045.80954190458, 19402.902985485052, 19719.70420443691, 19726.0, 5717.914231286534, 5911.438413350725, 5953.434423729739, 5966.2840459144745, 6062.03007518797, 5789.842031593698, 5883.205767221413, 5898.439648233432, 5929.288485381739, 5940.287165540141, 5748.281464816898, 5803.854903627401, 5894.17481552583, 5920.970395148018, 5930.97034514829, 5787.942120578825, 5882.147088672119, 5912.733926973275, 5916.585838991251, 5924.1113832924975, 5014.473480284554, 5187.559057480119, 5219.217117432378, 5231.869203269911, 5243.239730239094, 22784.772152278598, 23386.883065584734, 23480.530389392115, 23820.285391438283, 23920.641190382157, 2361.6575596538405, 2525.8358206716503, 2672.024710980478, 2928.6144024184864, 3169.41365847319, 14374.20941848198, 14963.326650300764, 15069.924650376788, 15092.849071509254, 15523.223838808015, 1978.584497255578, 2007.3375785990588, 2033.4001469566365, 2038.714579958807, 2041.3365656161807, 82498.58750706268, 83266.58366708127, 84810.0, 85962.57018714867, 86079.56960215222, 10425.478726063666, 10463.215258855616, 10644.148468122532, 10754.946225268823, 10966.287191332538, 14687.485937992118, 14746.6727994481, 14788.11271323724, 14852.108873467627, 14875.256237188098, 7802.180771018961, 8080.8383832323025, 8181.304589109874, 8262.876056859152, 8326.167383261625, 7606.847863042708, 7741.800020996755, 7819.257170568787, 7952.880706789403, 8014.398920081017, 6454.386833250834, 6550.526131620347, 6593.208814942238, 6667.33326667339, 6780.593164410151, 1925.8844469331605, 1951.3072859135086, 1967.2327792160781, 2014.717939488473, 2016.637005339053, 930.2418528898926, 989.9752506187259, 1089.8256278995323, 1108.6396921000708, 1130.8892176936893, 19932.70100948487, 20148.697769533468, 20329.390118296476, 20431.79568204299, 20469.15777580025, 1016.3444578246989, 1036.2176556699644, 1048.0, 1066.3015724700333, 1087.717193529688, 10903.945480272707, 11650.708732281591, 11683.0, 11696.356700381391, 11707.590234341927, 433078.0, 442074.0, 444305.0, 445304.0, 448978.0, 49321.753391232814, 52033.7398313006, 80750.59624701839, 80928.0, 83647.5817620908, 997.7705127820642, 1017.5827910556636, 1031.4739482863642, 1033.3851358441716, 1036.4662198967537, 16984.66030679404, 17582.472525824247, 18244.361447349278, 18386.264549417872, 18658.16038278308, 27633.0, 34169.48745768766, 34732.65267347294, 41514.37728434015, 42070.57929420667, 64015.0, 64959.0, 65150.0, 66363.33636663572, 66914.66542667255, 8538.359623028173, 8545.87181192295, 8767.298616110824, 8841.955790221007, 8985.831841860516, 12816.0, 13425.731485370043, 13426.462941482232, 13540.79688804649, 13745.869390244528, 11836.76326473483, 11878.82181767257, 12039.699007524881, 12104.576339828063, 12373.75252494963, 11333.716657083638, 11810.232334898204, 12021.398930053638, 12209.267443953391, 12475.93762031184, 12245.14284000147, 12515.87484125147, 12595.765096277035, 12601.676823933354, 12671.796179362946, 8542.871856922275, 8723.214910658071, 8724.3892927497, 8955.552222388724, 9037.141471560191, 8475.576221188792, 11286.717832054264, 11972.58095966637, 11973.401329933642, 12161.635150945485], "value": 9457.732408914682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.7167638148753, 1507.4874542655498, 1641.3926847066587, 1803.0624075480741, 1803.8647101467384, 7930.643121059552, 8531.616077276522, 8698.95650521748, 9295.535223238845, 9318.114779095984, 8740.475571465717, 9018.819623607524, 9060.048694887024, 9106.40808347457, 9125.133112354333, 2319.8376113672048, 2365.2431222008963, 2369.099742098, 2369.4431808524982, 2395.688560487134, 2363.633636786301, 2367.502824406868, 2430.052279610953, 2431.173401043645, 2439.499902519979, 2370.277065495023, 2394.090245706629, 2394.293683363412, 2433.6227884677814, 2441.7192022917325, 2326.604477238865, 2341.2156927429246, 2352.752960939111, 2355.6348765941307, 2406.302172370011, 2312.791848733605, 2317.501737126509, 2317.582835089683, 2319.721633404002, 2335.614623587106, 8945.239654629364, 8946.86579701305, 9042.593083311267, 9053.683121090797, 9074.319426043074, 5343.412224655285, 5413.648112872651, 5428.348598168205, 5438.646487978269, 5510.311211098613, 3351.6815902489225, 3358.8320583970703, 3385.3737058643983, 3410.641882602316, 3429.4855771634457, 1186.7567148734488, 1198.1309157713995, 1200.4897918384652, 1208.6796998795326, 1223.9755204895941, 12253.081018923616, 12347.320897350643, 12348.444320005621, 12438.689032774162, 12467.0, 4443.533428989909, 4689.742064186503, 4779.474257831635, 4792.856214313576, 4821.156297647897, 10467.42429166388, 10530.15758739299, 10531.368117912949, 10549.314294570828, 10574.788504229873, 5393.7033463159905, 5408.405075441777, 5435.619506634498, 5441.238226648273, 5447.428020057916, 4387.254166791653, 4786.090642777861, 4877.341558889575, 4951.282064100686, 4959.82640607577, 3801.258754542893, 4051.622448367569, 4060.127072679329, 4129.958700413017, 4135.1316223593385, 1251.5744646819942, 1265.0, 1268.498942917561, 1289.704326299189, 1315.1714419915584, 968.4141094637642, 980.07872599756, 994.8109859126743, 1010.2675560218929, 1015.0, 6040.637561746222, 6049.909251361233, 6098.451139397475, 6146.938530614637, 6150.846228844314, 455.26020217147135, 456.5480174627162, 466.54511850945056, 466.6779921853978, 467.71001978773376, 4196.790160491963, 4257.510386305615, 4328.415663885398, 4335.176316499918, 4447.110577884371, 10777.407242601575, 11289.548418063185, 11305.604303849326, 11318.434078296052, 11334.376609286568, 11166.665000050012, 11213.94393028046, 11215.60745373908, 11221.046211072151, 11230.606928757617, 7792.727254546064, 8131.14622964592, 8141.0, 8303.211194936592, 8451.028131764926, 6155.630662160284, 6243.344448832807, 6278.215223097113, 6396.0405939109505, 6506.902396463962, 9697.806043879224, 10135.493225338556, 10294.330868493524, 10302.639407620996, 10367.688969330931, 10226.437545935045, 10410.47947602632, 10421.218408619536, 10469.424181670081, 10477.42374169428, 7114.288571142844, 7570.205128461653, 7675.155732869492, 7857.135715071452, 8032.3975701823765, 8649.264812491008, 8813.515256660945, 8833.955830220808, 8848.601812918305, 8850.070742571937, 7459.552426854406, 7616.885746713693, 7672.271134242238, 7684.568104160939, 7943.920560794318, 7255.020572222682, 7286.96356518214, 7314.268573142643, 7466.440016998856, 7518.699252029857, 7097.609631470112, 7289.635518224173, 7298.598577078099, 7302.415806735342, 7324.487285889936, 5182.740862956913, 5216.869578260574, 5223.712695801615, 5325.973370133124, 5477.260569823023, 5156.381234251914, 5260.158374660036, 5294.258803767552, 5339.092354299701, 5495.6153069284765], "value": 4645.192010113305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.7761583315429, 332.95784195468184, 334.29964224948725, 338.8018009464463, 345.16297977404787, 5357.589084911786, 5393.9212157568545, 5577.609567330289, 5584.832455026346, 5600.019996500611, 5402.78388864445, 5482.91775623366, 5484.61607687461, 5505.229267902497, 5509.917351239735, 4256.787160641963, 4338.197433474801, 4347.673924455663, 4359.651227901776, 4363.127374525092, 4173.290540608089, 4312.202242585132, 4322.157179350028, 4357.716748411359, 4377.489766030714, 4292.59220374064, 4296.033392486696, 4312.374705667692, 4314.266574682296, 4325.243082460573, 4310.374995625648, 4316.762578058221, 4320.438343015419, 4333.06839029607, 4340.826366945318, 3511.157322242669, 3838.155605766755, 3859.6912247020173, 3859.7298189126773, 3873.9418908716393, 5277.255826969992, 5288.576913846883, 5303.178007408857, 5311.389190243133, 5323.600729945231, 4808.735519546423, 4852.053849499349, 4853.4418541867435, 4873.853784386474, 4895.559399654013, 5471.316085489314, 5673.943260567383, 5681.403452637496, 5699.860027994418, 5706.172604972256, 4074.246264441088, 4098.766172436, 4099.795010249505, 4104.240715467618, 4122.855700050483, 5980.28236611605, 6005.3394126646035, 6006.975326531235, 6010.158577799068, 6026.668533230671, 4092.1406504633765, 4168.562300958416, 4241.660667146621, 4246.426732391149, 4259.574042595716, 4245.23585754561, 4254.29804082323, 4257.680673949404, 4260.403543503912, 4281.293586558245, 4874.341963834908, 4912.214045752662, 4915.5330243626795, 4924.9507504925205, 4947.25791131326, 5682.7442765075675, 5799.3040835100055, 5858.209141765892, 5863.648181109147, 5889.146073819358, 1450.833154187282, 1467.156385078584, 1472.4110355857529, 1474.9527835236888, 1484.346887369554, 900.7522931193843, 924.778053267211, 938.5025936253796, 942.1614762861059, 943.8820147481565, 4879.754962949599, 4919.754012299442, 4923.556879880828, 4933.506649335038, 4944.159492886146, 5135.794568217304, 5158.890838469747, 5254.950569277985, 5257.947420525822, 5326.9467305327225, 4602.493725690171, 4920.335754673145, 4921.827736029221, 4950.737561921687, 4976.651634385558, 2757.7793776497833, 2767.363506393541, 2778.4304217635336, 2781.707920668341, 2793.69269380368, 5442.782288708408, 5455.645383050169, 5475.5072043516275, 5475.561955043587, 5539.806106786243, 5114.71869047206, 5264.263003179558, 5300.416954135042, 5346.198070289488, 5352.464753524617, 5417.83746487606, 5423.349198096174, 5437.8368648940595, 5444.618876678674, 5458.536024437967, 5246.3704355477585, 5253.789848406021, 5276.920846187233, 5322.760475778522, 5342.545883599782, 4680.836170734008, 5095.617828662791, 5109.437961824122, 5110.437851836369, 5167.431582525995, 5422.295101636762, 5427.371788463524, 5475.370332411664, 5475.988206486496, 5529.917051244315, 3889.7277190596387, 3985.740926839746, 4067.1255680028935, 4092.6112019358116, 4141.461609990682, 5846.883062338644, 5858.2677165354335, 5862.824115276549, 5871.91369596626, 5877.735501902339, 5577.768892443055, 5672.858178545569, 5746.712664366849, 5785.177669034409, 5823.5923485355615, 5626.271258439735, 5628.74670639814, 5633.436656334334, 5670.829875103754, 5703.258576385043, 5651.237082993744, 5680.11958146488, 5721.570882183936, 5721.599488035798, 5726.370099288992, 5467.808626698046, 5684.232628595087, 5745.712714364348, 5761.423857614205, 5809.170111414891, 5525.336959564878, 5568.693721845338, 5605.467480589337, 5663.631863928831, 5697.943020569907], "value": 4235.766499597817, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.5236522443024, 756.1926994483186, 785.414865924886, 838.9958050209748, 845.51382954801, 14641.0, 15126.168060756654, 15128.0, 15264.847351526496, 15350.769738453931, 14823.703525929475, 14825.110493370405, 14888.553343399688, 14972.700545989073, 14992.625184370396, 653.7483069018439, 773.9458237923347, 784.2118670735903, 805.0379796143582, 807.8949736534242, 821.2690705272313, 823.4853216739538, 825.2531459029558, 829.498153617062, 829.929455996241, 870.0690261420283, 874.2437791310502, 878.7363790862747, 879.9692010779625, 882.6822343956171, 861.2291998661194, 863.4258218284833, 867.4578388507183, 870.4777133719781, 874.4010352908215, 638.6136387485598, 639.4181295021555, 640.4716109209874, 640.8782331357028, 640.8814369341686, 13165.539206127836, 13168.73662526744, 13189.934050329783, 13217.14088584239, 13254.867451325556, 15083.698326033418, 15532.61168470786, 15558.9222053889, 15697.136657483834, 15982.360705571764, 12357.38213089351, 12510.874891251062, 12548.058895582868, 12567.622971310875, 12594.496220151183, 3852.5184351956004, 3906.277338692351, 3926.6466018058227, 4042.595740425934, 4044.5146582410007, 67348.32651673518, 70150.64924675395, 70394.29605703929, 81402.59298703469, 81567.0, 12016.519339226508, 12022.338771367484, 12081.818772718416, 12172.208806427554, 12402.689932751753, 21240.681389779165, 21273.149074036864, 21288.25491107804, 21322.78677213239, 21368.679469807965, 8187.918120818835, 8571.0, 8667.653293868301, 9016.459012459274, 9241.861372079424, 4526.547345265447, 4663.603593694506, 4735.502772208937, 4772.522747725269, 4837.540433658797, 3379.85085071077, 3511.94732079019, 3541.628129046413, 3552.307300076512, 3567.554055743032, 596.5853731656457, 597.8087012156068, 599.1043390131781, 603.6197195766727, 622.411820829321, 627.8210709947643, 644.3331152257391, 683.5317807302014, 692.1797669761349, 696.4324075878143, 8669.26311263537, 9107.635694572275, 9225.308101892386, 9574.664886728931, 9721.319507634538, 651.3519048546632, 658.7562601837255, 677.9220389655154, 684.4524380495584, 689.4622194688151, 4416.712913660602, 4728.38530990969, 4734.337192793012, 4742.810287588527, 4852.902941941212, 87062.0, 127183.09225361627, 127805.0, 131794.0, 131919.0, 110924.0, 111623.0, 112450.43774781073, 112590.0, 113185.43407283076, 96182.0, 96868.0, 98993.50503247438, 99335.50332248436, 101076.49461752939, 8614.827703445771, 8947.116152740033, 8951.41815781972, 8984.416012959136, 9051.411658242194, 51462.48537514727, 55030.44969550413, 56366.0, 57460.1380979294, 57513.13730293965, 79282.6035869817, 85251.57374213089, 85612.57193713992, 87314.0, 90103.0, 11300.0, 11558.479868405773, 11560.710982225512, 11834.881651183377, 11892.048636109264, 13192.736145277233, 13409.731805363643, 13415.262160581262, 13428.19430834153, 14041.1575305482, 12565.560205392767, 13330.800037999632, 13383.39774710121, 13384.665383365495, 13397.933010334886, 11653.883461165618, 12236.327002014974, 12299.323537205539, 12695.682607934876, 12940.741185176432, 11878.109141814572, 12372.752544949231, 12435.129540932048, 12700.428480718574, 12730.618081457571, 9602.711918642452, 9664.613415463584, 9938.0, 9949.751256218653, 10018.448985305879, 8381.413301068867, 9430.95284523573, 10118.342307749972, 10456.215783816093, 10628.84056739134], "value": 7501.975283776428, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 108.0, 112.0, 115.0, 113.0, 113.0, 114.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 119.0, 148.0, 176.0, 120.0, 149.0, 149.0, 122.0, 185.0, 124.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 162.0, 163.0, 163.0, 172.0, 166.0, 163.0, 163.0, 165.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 180.0, 77.0, 76.0, 76.0, 76.0, 167.0, 77.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 85.0, 85.0, 86.0, 156.0, 84.0, 85.0, 141.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 119.0, 119.0, 118.0, 118.0, 118.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 149.0, 147.0, 150.0, 147.0, 148.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 95.0, 96.0, 100.0, 96.0, 97.0, 96.0, 96.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 52.0, 52.0, 53.0, 55.0, 53.0, 52.0, 52.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 64.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 76.0, 77.0, 74.0, 78.0, 81.0, 81.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 121.0, 123.0, 122.0, 125.0, 125.0, 129.0, 124.0, 144.0, 124.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 161.0, 162.0, 158.0, 158.0, 157.0, 163.0, 158.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 66.0], "value": 65.0, "unit": "score"}]}]} 05:43:50 INFO - Return code: 0 05:43:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:43:50 ERROR - # TBPL SUCCESS # 05:43:50 INFO - Running post-action listener: _resource_record_post_action 05:43:50 INFO - [mozharness: 2016-08-09 12:43:50.520801Z] Finished run-tests step (success) 05:43:50 INFO - Running post-run listener: _resource_record_post_run 05:43:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 559116288; Read time: 0; Write time: 562432 05:43:50 INFO - TinderboxPrint: CPU usage
13.5% 05:43:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:43:50 INFO - TinderboxPrint: I/O write bytes / time
559,116,288 / 562,432 05:43:50 INFO - TinderboxPrint: CPU idle
8,214.7 (86.5%) 05:43:50 INFO - TinderboxPrint: CPU user
1,219.6 (12.8%) 05:43:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:43:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261136384; Read time: 0; Write time: 340704 05:43:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297979904; Read time: 0; Write time: 221728 05:43:51 INFO - Running post-run listener: _upload_blobber_files 05:43:51 INFO - Blob upload gear active. 05:43:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43:51 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 05:43:51 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:43:51 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:43:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:52 INFO - (blobuploader) - INFO - Done attempting. 05:43:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:43:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:43:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:55 INFO - (blobuploader) - INFO - Done attempting. 05:43:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:43:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:43:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:56 INFO - (blobuploader) - INFO - Done attempting. 05:43:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:56 INFO - Return code: 0 05:43:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb062af1c41b9ad07e94520b115317a14047fa304483c907fa00f1ee94f0b2eedaf048d19396404b8f6b49c103f4e3024b2122191693e62217ca0a25a47e56e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fdbe5a8501b09b7dbfda00243fa71db3cc4c97c18657ce44e63627a2c8ce9a720fec5d311d59f43f6dd965dc1be0c206823cf92f7bb3cabfcdd8ef0dba72404", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a436f858a7a7aa33888deb1e58fbd1705bfb3a91ce12814143a8c48de40e408a5221218b3a2f96fa74d716679160e93173a5311f6dab5ecf51e51ff59695190"} 05:43:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:56 INFO - Contents: 05:43:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb062af1c41b9ad07e94520b115317a14047fa304483c907fa00f1ee94f0b2eedaf048d19396404b8f6b49c103f4e3024b2122191693e62217ca0a25a47e56e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fdbe5a8501b09b7dbfda00243fa71db3cc4c97c18657ce44e63627a2c8ce9a720fec5d311d59f43f6dd965dc1be0c206823cf92f7bb3cabfcdd8ef0dba72404", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a436f858a7a7aa33888deb1e58fbd1705bfb3a91ce12814143a8c48de40e408a5221218b3a2f96fa74d716679160e93173a5311f6dab5ecf51e51ff59695190"} 05:43:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:56 INFO - Copying logs to upload dir... 05:43:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.244099 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-09 05:43:55.523183) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:55.529129) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb062af1c41b9ad07e94520b115317a14047fa304483c907fa00f1ee94f0b2eedaf048d19396404b8f6b49c103f4e3024b2122191693e62217ca0a25a47e56e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fdbe5a8501b09b7dbfda00243fa71db3cc4c97c18657ce44e63627a2c8ce9a720fec5d311d59f43f6dd965dc1be0c206823cf92f7bb3cabfcdd8ef0dba72404", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a436f858a7a7aa33888deb1e58fbd1705bfb3a91ce12814143a8c48de40e408a5221218b3a2f96fa74d716679160e93173a5311f6dab5ecf51e51ff59695190"} build_url:https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb062af1c41b9ad07e94520b115317a14047fa304483c907fa00f1ee94f0b2eedaf048d19396404b8f6b49c103f4e3024b2122191693e62217ca0a25a47e56e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fdbe5a8501b09b7dbfda00243fa71db3cc4c97c18657ce44e63627a2c8ce9a720fec5d311d59f43f6dd965dc1be0c206823cf92f7bb3cabfcdd8ef0dba72404", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a436f858a7a7aa33888deb1e58fbd1705bfb3a91ce12814143a8c48de40e408a5221218b3a2f96fa74d716679160e93173a5311f6dab5ecf51e51ff59695190"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:55.555257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:55.555640) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470738917.380517-1884330427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:55.639767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:43:55.640121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:43:55.640452) ========= ========= Total master_lag: 0.17 =========