builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1470951320.49 results: success (0) buildid: 20160811130435 builduid: 70e0739b3ec8487e810ac7c5345c6832 revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.492812) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.493295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.493586) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.509184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.509549) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 14:35:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-08-11 14:35:20 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.653324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.653654) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016554 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.703432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:20.703796) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --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 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --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=78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 14:35:20,773 truncating revision to first 12 chars 2016-08-11 14:35:20,773 Setting DEBUG logging. 2016-08-11 14:35:20,773 attempt 1/10 2016-08-11 14:35:20,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61340bd78a4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 14:35:21,089 unpacking tar archive at: fx-team-61340bd78a4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:21.408591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:21.408925) ========= script_repo_revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:21.409508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:21.409800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 14:35:21.420776) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-11 14:35:21.421196) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:35:21 INFO - MultiFileLogger online at 20160811 14:35:21 in /builds/slave/test 14:35:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:35:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:35:21 INFO - {'append_to_log': False, 14:35:21 INFO - 'base_work_dir': '/builds/slave/test', 14:35:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:35:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:35:21 INFO - 'branch': 'Fx-Team-Non-PGO', 14:35:21 INFO - 'buildbot_json_path': 'buildprops.json', 14:35:21 INFO - 'config_files': ('talos/linux_config.py',), 14:35:21 INFO - 'default_actions': ('clobber', 14:35:21 INFO - 'read-buildbot-config', 14:35:21 INFO - 'download-and-extract', 14:35:21 INFO - 'populate-webroot', 14:35:21 INFO - 'create-virtualenv', 14:35:21 INFO - 'install', 14:35:21 INFO - 'run-tests'), 14:35:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:35:21 INFO - 'download_minidump_stackwalk': True, 14:35:21 INFO - 'download_symbols': 'ondemand', 14:35:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:35:21 INFO - 'tooltool.py': '/tools/tooltool.py', 14:35:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:35:21 INFO - '/tools/misc-python/virtualenv.py')}, 14:35:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:35:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:35:21 INFO - 'installer_path': 'installer.exe', 14:35:21 INFO - 'log_level': 'info', 14:35:21 INFO - 'log_name': 'talos', 14:35:21 INFO - 'log_to_console': True, 14:35:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:35:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:35:21 INFO - 'opt_config_files': (), 14:35:21 INFO - 'pip_index': False, 14:35:21 INFO - 'sps_profile': False, 14:35:21 INFO - 'sps_profile_interval': 0, 14:35:21 INFO - 'suite': 'dromaeojs-e10s', 14:35:21 INFO - 'system_bits': '32', 14:35:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:35:21 INFO - 'title': 'talos-linux64-ix-019', 14:35:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:35:21 INFO - 'use_talos_json': True, 14:35:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:35:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:35:21 INFO - 'work_dir': 'build'} 14:35:21 INFO - [mozharness: 2016-08-11 21:35:21.583610Z] Running clobber step. 14:35:21 INFO - Running pre-action listener: _resource_record_pre_action 14:35:21 INFO - Running main action method: clobber 14:35:21 INFO - rmtree: /builds/slave/test/build 14:35:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:35:22 INFO - Running post-action listener: _resource_record_post_action 14:35:22 INFO - [mozharness: 2016-08-11 21:35:22.029906Z] Finished clobber step (success) 14:35:22 INFO - [mozharness: 2016-08-11 21:35:22.030007Z] Running read-buildbot-config step. 14:35:22 INFO - Running pre-action listener: _resource_record_pre_action 14:35:22 INFO - Running main action method: read_buildbot_config 14:35:22 INFO - Using buildbot properties: 14:35:22 INFO - { 14:35:22 INFO - "project": "", 14:35:22 INFO - "product": "firefox", 14:35:22 INFO - "script_repo_revision": "production", 14:35:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:35:22 INFO - "repository": "", 14:35:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:35:22 INFO - "buildid": "20160811130435", 14:35:22 INFO - "pgo_build": "False", 14:35:22 INFO - "basedir": "/builds/slave/test", 14:35:22 INFO - "buildnumber": 1747, 14:35:22 INFO - "slavename": "talos-linux64-ix-019", 14:35:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:35:22 INFO - "platform": "ubuntu64_hw", 14:35:22 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 14:35:22 INFO - "branch": "fx-team", 14:35:22 INFO - "repo_path": "integration/fx-team", 14:35:22 INFO - "revision": "61340bd78a4bf05890f4b84a6ca57ba01c0ee29b", 14:35:22 INFO - "stage_platform": "linux64", 14:35:22 INFO - "builduid": "70e0739b3ec8487e810ac7c5345c6832", 14:35:22 INFO - "slavebuilddir": "test" 14:35:22 INFO - } 14:35:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:35:22 INFO - Running post-action listener: _resource_record_post_action 14:35:22 INFO - [mozharness: 2016-08-11 21:35:22.032441Z] Finished read-buildbot-config step (success) 14:35:22 INFO - [mozharness: 2016-08-11 21:35:22.032530Z] Running download-and-extract step. 14:35:22 INFO - Running pre-action listener: _resource_record_pre_action 14:35:22 INFO - Running main action method: download_and_extract 14:35:22 INFO - mkdir: /builds/slave/test/build/tests 14:35:22 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')]} 14:35:22 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:35:22 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:22 INFO - Downloaded 1361 bytes. 14:35:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:35:22 INFO - Using the following test package requirements: 14:35:22 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:35:22 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:35:22 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:35:22 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'jsshell-linux-x86_64.zip'], 14:35:22 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:35:22 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:35:22 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:35:22 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:35:22 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:35:22 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:35:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:35:22 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')]} 14:35:22 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:35:22 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:23 INFO - Downloaded 20262322 bytes. 14:35:23 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'] 14:35:23 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 14:35:24 INFO - Return code: 0 14:35:24 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 14:35:24 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')]} 14:35:24 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:35:24 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:25 INFO - Downloaded 20262322 bytes. 14:35:25 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'] 14:35:25 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 14:35:27 INFO - Return code: 0 14:35:27 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')]} 14:35:27 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:35:27 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:27 INFO - Downloaded 14413719 bytes. 14:35:27 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'] 14:35:27 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 14:35:28 INFO - Return code: 0 14:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:28 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:35:28 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:35:29 INFO - Downloaded 55620330 bytes. 14:35:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:35:29 INFO - mkdir: /builds/slave/test/properties 14:35:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:35:29 INFO - Writing to file /builds/slave/test/properties/build_url 14:35:29 INFO - Contents: 14:35:29 INFO - build_url:https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:35:30 INFO - Running post-action listener: _resource_record_post_action 14:35:30 INFO - Running post-action listener: set_extra_try_arguments 14:35:30 INFO - [mozharness: 2016-08-11 21:35:30.079910Z] Finished download-and-extract step (success) 14:35:30 INFO - [mozharness: 2016-08-11 21:35:30.080144Z] Running populate-webroot step. 14:35:30 INFO - Running pre-action listener: _resource_record_pre_action 14:35:30 INFO - Running main action method: populate_webroot 14:35:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:35:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:35:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:35:30 INFO - '--tppagecycles', 14:35:30 INFO - '7'], 14:35:30 INFO - 'tests': ['tsvgm']}}, 14:35:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:35:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:35:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:35:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:35:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['damp', 'tps']}, 14:35:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'tests': ['damp', 'tps']}, 14:35:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['dromaeo_dom']}, 14:35:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:35:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['basic_compositor_video']}, 14:35:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:35:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['a11yr', 14:35:30 INFO - 'ts_paint', 14:35:30 INFO - 'tpaint', 14:35:30 INFO - 'sessionrestore', 14:35:30 INFO - 'sessionrestore_no_auto_restore', 14:35:30 INFO - 'tabpaint']}, 14:35:30 INFO - 'other-e10s': {'tests': ['a11yr', 14:35:30 INFO - 'ts_paint', 14:35:30 INFO - 'tpaint', 14:35:30 INFO - 'sessionrestore', 14:35:30 INFO - 'sessionrestore_no_auto_restore', 14:35:30 INFO - 'tabpaint']}, 14:35:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:35:30 INFO - 'ts_paint', 14:35:30 INFO - 'tpaint', 14:35:30 INFO - 'sessionrestore', 14:35:30 INFO - 'sessionrestore_no_auto_restore', 14:35:30 INFO - 'tabpaint']}, 14:35:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:35:30 INFO - 'ts_paint', 14:35:30 INFO - 'tpaint', 14:35:30 INFO - 'sessionrestore', 14:35:30 INFO - 'sessionrestore_no_auto_restore', 14:35:30 INFO - 'tabpaint']}, 14:35:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['a11yr', 14:35:30 INFO - 'ts_paint', 14:35:30 INFO - 'tpaint', 14:35:30 INFO - 'sessionrestore', 14:35:30 INFO - 'sessionrestore_no_auto_restore', 14:35:30 INFO - 'tabpaint']}, 14:35:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['a11yr', 14:35:30 INFO - 'ts_paint', 14:35:30 INFO - 'tpaint', 14:35:30 INFO - 'sessionrestore', 14:35:30 INFO - 'sessionrestore_no_auto_restore', 14:35:30 INFO - 'tabpaint']}, 14:35:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['tsvgx', 14:35:30 INFO - 'tsvgr_opacity', 14:35:30 INFO - 'tart', 14:35:30 INFO - 'tscrollx', 14:35:30 INFO - 'cart']}, 14:35:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:35:30 INFO - 'tsvgr_opacity', 14:35:30 INFO - 'tart', 14:35:30 INFO - 'tscrollx', 14:35:30 INFO - 'cart']}, 14:35:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'talos_options': ['--disable-e10s'], 14:35:30 INFO - 'tests': ['tp5o']}, 14:35:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'tests': ['tp5o']}, 14:35:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'talos_options': ['--disable-e10s', 14:35:30 INFO - '--xperf_path', 14:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:30 INFO - 'tests': ['tp5n']}, 14:35:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:30 INFO - 'talos_options': ['--xperf_path', 14:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:30 INFO - 'tests': ['tp5n']}}, 14:35:30 INFO - 'talos.zip': {'path': '', 14:35:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:35:30 INFO - Running post-action listener: _resource_record_post_action 14:35:30 INFO - [mozharness: 2016-08-11 21:35:30.103338Z] Finished populate-webroot step (success) 14:35:30 INFO - [mozharness: 2016-08-11 21:35:30.103427Z] Running create-virtualenv step. 14:35:30 INFO - Running pre-action listener: _resource_record_pre_action 14:35:30 INFO - Running main action method: create_virtualenv 14:35:30 INFO - Creating virtualenv /builds/slave/test/build/venv 14:35:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:35:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:35:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:35:30 INFO - Using real prefix '/usr' 14:35:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:35:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:35:32 INFO - Installing pip.................done. 14:35:32 INFO - Return code: 0 14:35:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:32 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 14:35:32 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 14:35:32 INFO - Using env: {'DISPLAY': ':0', 14:35:32 INFO - 'HOME': '/home/cltbld', 14:35:32 INFO - 'LANG': 'en_US.UTF-8', 14:35:32 INFO - 'LANGUAGE': 'en_US:en', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MAIL': '/var/mail/cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SHLVL': '1', 14:35:32 INFO - 'TERM': 'linux', 14:35:32 INFO - 'TMOUT': '86400', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - '_': '/tools/buildbot/bin/python'} 14:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:35:32 INFO - Cleaning up... 14:35:32 INFO - Return code: 0 14:35:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:32 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 14:35:32 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 14:35:32 INFO - Using env: {'DISPLAY': ':0', 14:35:32 INFO - 'HOME': '/home/cltbld', 14:35:32 INFO - 'LANG': 'en_US.UTF-8', 14:35:32 INFO - 'LANGUAGE': 'en_US:en', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MAIL': '/var/mail/cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SHLVL': '1', 14:35:32 INFO - 'TERM': 'linux', 14:35:32 INFO - 'TMOUT': '86400', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - '_': '/tools/buildbot/bin/python'} 14:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:33 INFO - Downloading/unpacking psutil>=3.1.1 14:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:35:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:36 INFO - Installing collected packages: psutil 14:35:36 INFO - Running setup.py install for psutil 14:35:36 INFO - building 'psutil._psutil_linux' extension 14:35:36 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 14:35:36 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 14:35:36 INFO - building 'psutil._psutil_posix' extension 14:35:36 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 14:35:36 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 14:35:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:36 INFO - Successfully installed psutil 14:35:36 INFO - Cleaning up... 14:35:36 INFO - Return code: 0 14:35:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:35: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')]} 14:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:36 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:36 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 14:35:36 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 14:35:36 INFO - Using env: {'DISPLAY': ':0', 14:35:36 INFO - 'HOME': '/home/cltbld', 14:35:36 INFO - 'LANG': 'en_US.UTF-8', 14:35:36 INFO - 'LANGUAGE': 'en_US:en', 14:35:36 INFO - 'LOGNAME': 'cltbld', 14:35:36 INFO - 'MAIL': '/var/mail/cltbld', 14:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:36 INFO - 'MOZ_NO_REMOTE': '1', 14:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:36 INFO - 'NO_EM_RESTART': '1', 14:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:36 INFO - 'PWD': '/builds/slave/test', 14:35:36 INFO - 'SHELL': '/bin/bash', 14:35:36 INFO - 'SHLVL': '1', 14:35:36 INFO - 'TERM': 'linux', 14:35:36 INFO - 'TMOUT': '86400', 14:35:36 INFO - 'USER': 'cltbld', 14:35:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:36 INFO - '_': '/tools/buildbot/bin/python'} 14:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:35:36 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 14:35:36 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 14:35:36 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 14:35:36 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 14:35:36 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 14:35:36 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 14:35:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:35:39 INFO - Installing collected packages: mozsystemmonitor 14:35:39 INFO - Running setup.py install for mozsystemmonitor 14:35:40 INFO - Successfully installed mozsystemmonitor 14:35:40 INFO - Cleaning up... 14:35:40 INFO - Return code: 0 14:35:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:40 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:40 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 14:35:40 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 14:35:40 INFO - Using env: {'DISPLAY': ':0', 14:35:40 INFO - 'HOME': '/home/cltbld', 14:35:40 INFO - 'LANG': 'en_US.UTF-8', 14:35:40 INFO - 'LANGUAGE': 'en_US:en', 14:35:40 INFO - 'LOGNAME': 'cltbld', 14:35:40 INFO - 'MAIL': '/var/mail/cltbld', 14:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:40 INFO - 'MOZ_NO_REMOTE': '1', 14:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:40 INFO - 'NO_EM_RESTART': '1', 14:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:40 INFO - 'PWD': '/builds/slave/test', 14:35:40 INFO - 'SHELL': '/bin/bash', 14:35:40 INFO - 'SHLVL': '1', 14:35:40 INFO - 'TERM': 'linux', 14:35:40 INFO - 'TMOUT': '86400', 14:35:40 INFO - 'USER': 'cltbld', 14:35:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:40 INFO - '_': '/tools/buildbot/bin/python'} 14:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:41 INFO - Downloading/unpacking jsonschema==2.5.1 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:35:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:35:42 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 14:35:42 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 14:35:42 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 14:35:42 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 14:35:42 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 14:35:42 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 14:35:43 INFO - Downloading functools32-3.2.3-2.tar.gz 14:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:35:43 INFO - warning: no files found matching '*.txt' 14:35:43 INFO - no previously-included directories found matching 'build' 14:35:43 INFO - no previously-included directories found matching 'dist' 14:35:43 INFO - no previously-included directories found matching '.git*' 14:35:43 INFO - Installing collected packages: jsonschema, functools32 14:35:43 INFO - Running setup.py install for functools32 14:35:43 INFO - warning: no files found matching '*.txt' 14:35:43 INFO - no previously-included directories found matching 'build' 14:35:43 INFO - no previously-included directories found matching 'dist' 14:35:43 INFO - no previously-included directories found matching '.git*' 14:35:43 INFO - Successfully installed jsonschema functools32 14:35:43 INFO - Cleaning up... 14:35:43 INFO - Return code: 0 14:35:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:43 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:43 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 14:35:43 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 14:35:43 INFO - Using env: {'DISPLAY': ':0', 14:35:43 INFO - 'HOME': '/home/cltbld', 14:35:43 INFO - 'LANG': 'en_US.UTF-8', 14:35:43 INFO - 'LANGUAGE': 'en_US:en', 14:35:43 INFO - 'LOGNAME': 'cltbld', 14:35:43 INFO - 'MAIL': '/var/mail/cltbld', 14:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:43 INFO - 'MOZ_NO_REMOTE': '1', 14:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:43 INFO - 'NO_EM_RESTART': '1', 14:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:43 INFO - 'PWD': '/builds/slave/test', 14:35:43 INFO - 'SHELL': '/bin/bash', 14:35:43 INFO - 'SHLVL': '1', 14:35:43 INFO - 'TERM': 'linux', 14:35:43 INFO - 'TMOUT': '86400', 14:35:43 INFO - 'USER': 'cltbld', 14:35:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:43 INFO - '_': '/tools/buildbot/bin/python'} 14:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:35:43 INFO - Cleaning up... 14:35:43 INFO - Return code: 0 14:35:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:43 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:43 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 14:35:43 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 14:35:43 INFO - Using env: {'DISPLAY': ':0', 14:35:43 INFO - 'HOME': '/home/cltbld', 14:35:43 INFO - 'LANG': 'en_US.UTF-8', 14:35:43 INFO - 'LANGUAGE': 'en_US:en', 14:35:43 INFO - 'LOGNAME': 'cltbld', 14:35:43 INFO - 'MAIL': '/var/mail/cltbld', 14:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:43 INFO - 'MOZ_NO_REMOTE': '1', 14:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:43 INFO - 'NO_EM_RESTART': '1', 14:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:43 INFO - 'PWD': '/builds/slave/test', 14:35:43 INFO - 'SHELL': '/bin/bash', 14:35:43 INFO - 'SHLVL': '1', 14:35:43 INFO - 'TERM': 'linux', 14:35:43 INFO - 'TMOUT': '86400', 14:35:43 INFO - 'USER': 'cltbld', 14:35:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:43 INFO - '_': '/tools/buildbot/bin/python'} 14:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:43 INFO - Downloading/unpacking blobuploader==1.2.4 14:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:35:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:35:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:46 INFO - Downloading docopt-0.6.1.tar.gz 14:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:35:46 INFO - Installing collected packages: blobuploader, requests, docopt 14:35:46 INFO - Running setup.py install for blobuploader 14:35:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:35:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:35:46 INFO - Running setup.py install for requests 14:35:46 INFO - Running setup.py install for docopt 14:35:46 INFO - Successfully installed blobuploader requests docopt 14:35:46 INFO - Cleaning up... 14:35:47 INFO - Return code: 0 14:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:47 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:47 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 14:35:47 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 14:35:47 INFO - Using env: {'DISPLAY': ':0', 14:35:47 INFO - 'HOME': '/home/cltbld', 14:35:47 INFO - 'LANG': 'en_US.UTF-8', 14:35:47 INFO - 'LANGUAGE': 'en_US:en', 14:35:47 INFO - 'LOGNAME': 'cltbld', 14:35:47 INFO - 'MAIL': '/var/mail/cltbld', 14:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:47 INFO - 'MOZ_NO_REMOTE': '1', 14:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:47 INFO - 'NO_EM_RESTART': '1', 14:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:47 INFO - 'PWD': '/builds/slave/test', 14:35:47 INFO - 'SHELL': '/bin/bash', 14:35:47 INFO - 'SHLVL': '1', 14:35:47 INFO - 'TERM': 'linux', 14:35:47 INFO - 'TMOUT': '86400', 14:35:47 INFO - 'USER': 'cltbld', 14:35:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:47 INFO - '_': '/tools/buildbot/bin/python'} 14:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:47 INFO - Running setup.py (path:/tmp/pip-ABd1h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:47 INFO - Running setup.py (path:/tmp/pip-oS8DPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:47 INFO - Running setup.py (path:/tmp/pip-S81mJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:47 INFO - Running setup.py (path:/tmp/pip-0qDShi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:47 INFO - Running setup.py (path:/tmp/pip-mJrRdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:47 INFO - Running setup.py (path:/tmp/pip-0U5O8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:47 INFO - Running setup.py (path:/tmp/pip-EiU4gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:47 INFO - Running setup.py (path:/tmp/pip-5CFvkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:47 INFO - Running setup.py (path:/tmp/pip-yq8TAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:47 INFO - Running setup.py (path:/tmp/pip-4fCBnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:47 INFO - Running setup.py (path:/tmp/pip-7MbV7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:48 INFO - Running setup.py (path:/tmp/pip-w_hr4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:48 INFO - Running setup.py (path:/tmp/pip-eB0Adw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:48 INFO - Running setup.py (path:/tmp/pip-J3Hvwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:48 INFO - Running setup.py (path:/tmp/pip-2p5f8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:48 INFO - Running setup.py (path:/tmp/pip-anPWM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:48 INFO - Running setup.py (path:/tmp/pip-fOOqul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:35:48 INFO - Running setup.py install for manifestparser 14:35:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:35:48 INFO - Running setup.py install for mozcrash 14:35:48 INFO - Running setup.py install for mozdebug 14:35:48 INFO - Running setup.py install for mozdevice 14:35:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:35:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:35:48 INFO - Running setup.py install for mozfile 14:35:48 INFO - Running setup.py install for mozhttpd 14:35:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Running setup.py install for mozinfo 14:35:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Running setup.py install for mozInstall 14:35:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Running setup.py install for mozleak 14:35:49 INFO - Running setup.py install for mozlog 14:35:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Running setup.py install for moznetwork 14:35:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Running setup.py install for mozprocess 14:35:49 INFO - Running setup.py install for mozprofile 14:35:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Running setup.py install for mozrunner 14:35:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:35:49 INFO - Running setup.py install for mozscreenshot 14:35:50 INFO - Running setup.py install for moztest 14:35:50 INFO - Running setup.py install for mozversion 14:35:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:35:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:35:50 INFO - Cleaning up... 14:35:50 INFO - Return code: 0 14:35:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:50 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:50 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 14:35:50 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 14:35:50 INFO - Using env: {'DISPLAY': ':0', 14:35:50 INFO - 'HOME': '/home/cltbld', 14:35:50 INFO - 'LANG': 'en_US.UTF-8', 14:35:50 INFO - 'LANGUAGE': 'en_US:en', 14:35:50 INFO - 'LOGNAME': 'cltbld', 14:35:50 INFO - 'MAIL': '/var/mail/cltbld', 14:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:50 INFO - 'MOZ_NO_REMOTE': '1', 14:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:50 INFO - 'NO_EM_RESTART': '1', 14:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:50 INFO - 'PWD': '/builds/slave/test', 14:35:50 INFO - 'SHELL': '/bin/bash', 14:35:50 INFO - 'SHLVL': '1', 14:35:50 INFO - 'TERM': 'linux', 14:35:50 INFO - 'TMOUT': '86400', 14:35:50 INFO - 'USER': 'cltbld', 14:35:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:50 INFO - '_': '/tools/buildbot/bin/python'} 14:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:50 INFO - Running setup.py (path:/tmp/pip-FkJHAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:50 INFO - Running setup.py (path:/tmp/pip-tXunRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:50 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)) 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:50 INFO - Running setup.py (path:/tmp/pip-flKH3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:50 INFO - Running setup.py (path:/tmp/pip-bIcyeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:50 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)) 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:50 INFO - Running setup.py (path:/tmp/pip-XivCMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:50 INFO - Running setup.py (path:/tmp/pip-Y9218j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:50 INFO - Running setup.py (path:/tmp/pip-DMNyok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:50 INFO - Running setup.py (path:/tmp/pip-q0y96t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:51 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)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:51 INFO - Running setup.py (path:/tmp/pip-uKvX_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:51 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)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:51 INFO - Running setup.py (path:/tmp/pip-3ZyZti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:51 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)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:51 INFO - Running setup.py (path:/tmp/pip-ma8BFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:51 INFO - Running setup.py (path:/tmp/pip-Il_352-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:51 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)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:51 INFO - Running setup.py (path:/tmp/pip-tgT9gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:51 INFO - Running setup.py (path:/tmp/pip-v4JNSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:51 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)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:51 INFO - Running setup.py (path:/tmp/pip-tyrPRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:51 INFO - Running setup.py (path:/tmp/pip-rRm1ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:51 INFO - Running setup.py (path:/tmp/pip-PQIgAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:53 INFO - Downloading blessings-1.6.tar.gz 14:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:53 INFO - Installing collected packages: blessings 14:35:53 INFO - Running setup.py install for blessings 14:35:53 INFO - Successfully installed blessings 14:35:53 INFO - Cleaning up... 14:35:53 INFO - Return code: 0 14:35:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:54 INFO - Reading from file tmpfile_stdout 14:35:54 INFO - Current package versions: 14:35:54 INFO - argparse == 1.2.1 14:35:54 INFO - blessings == 1.6 14:35:54 INFO - blobuploader == 1.2.4 14:35:54 INFO - docopt == 0.6.1 14:35:54 INFO - functools32 == 3.2.3-2 14:35:54 INFO - jsonschema == 2.5.1 14:35:54 INFO - manifestparser == 1.1 14:35:54 INFO - mozInstall == 1.12 14:35:54 INFO - mozcrash == 0.17 14:35:54 INFO - mozdebug == 0.1 14:35:54 INFO - mozdevice == 0.48 14:35:54 INFO - mozfile == 1.2 14:35:54 INFO - mozhttpd == 0.7 14:35:54 INFO - mozinfo == 0.9 14:35:54 INFO - mozleak == 0.1 14:35:54 INFO - mozlog == 3.3 14:35:54 INFO - moznetwork == 0.27 14:35:54 INFO - mozprocess == 0.23 14:35:54 INFO - mozprofile == 0.28 14:35:54 INFO - mozrunner == 6.12 14:35:54 INFO - mozscreenshot == 0.1 14:35:54 INFO - mozsystemmonitor == 0.3 14:35:54 INFO - moztest == 0.7 14:35:54 INFO - mozversion == 1.4 14:35:54 INFO - psutil == 3.1.1 14:35:54 INFO - requests == 1.2.3 14:35:54 INFO - wsgiref == 0.1.2 14:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:54 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:54 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 14:35:54 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 14:35:54 INFO - Using env: {'DISPLAY': ':0', 14:35:54 INFO - 'HOME': '/home/cltbld', 14:35:54 INFO - 'LANG': 'en_US.UTF-8', 14:35:54 INFO - 'LANGUAGE': 'en_US:en', 14:35:54 INFO - 'LOGNAME': 'cltbld', 14:35:54 INFO - 'MAIL': '/var/mail/cltbld', 14:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:54 INFO - 'MOZ_NO_REMOTE': '1', 14:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:54 INFO - 'NO_EM_RESTART': '1', 14:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:54 INFO - 'PWD': '/builds/slave/test', 14:35:54 INFO - 'SHELL': '/bin/bash', 14:35:54 INFO - 'SHLVL': '1', 14:35:54 INFO - 'TERM': 'linux', 14:35:54 INFO - 'TMOUT': '86400', 14:35:54 INFO - 'USER': 'cltbld', 14:35:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:54 INFO - '_': '/tools/buildbot/bin/python'} 14:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 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)) 14:35:54 INFO - Cleaning up... 14:35:54 INFO - Return code: 0 14:35:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:54 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 0x1e48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2077400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', '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 14:35:54 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 14:35:54 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 14:35:54 INFO - Using env: {'DISPLAY': ':0', 14:35:54 INFO - 'HOME': '/home/cltbld', 14:35:54 INFO - 'LANG': 'en_US.UTF-8', 14:35:54 INFO - 'LANGUAGE': 'en_US:en', 14:35:54 INFO - 'LOGNAME': 'cltbld', 14:35:54 INFO - 'MAIL': '/var/mail/cltbld', 14:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:54 INFO - 'MOZ_NO_REMOTE': '1', 14:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:54 INFO - 'NO_EM_RESTART': '1', 14:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:54 INFO - 'PWD': '/builds/slave/test', 14:35:54 INFO - 'SHELL': '/bin/bash', 14:35:54 INFO - 'SHLVL': '1', 14:35:54 INFO - 'TERM': 'linux', 14:35:54 INFO - 'TMOUT': '86400', 14:35:54 INFO - 'USER': 'cltbld', 14:35:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:54 INFO - '_': '/tools/buildbot/bin/python'} 14:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:35:54 INFO - Cleaning up... 14:35:54 INFO - Return code: 0 14:35:54 INFO - Running post-action listener: _resource_record_post_action 14:35:54 INFO - Running post-action listener: _start_resource_monitoring 14:35:54 INFO - Starting resource monitoring. 14:35:54 INFO - [mozharness: 2016-08-11 21:35:54.564457Z] Finished create-virtualenv step (success) 14:35:54 INFO - [mozharness: 2016-08-11 21:35:54.564943Z] Running install step. 14:35:54 INFO - Running pre-action listener: _resource_record_pre_action 14:35:54 INFO - Running main action method: install 14:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:54 INFO - Reading from file tmpfile_stdout 14:35:54 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:54 INFO - Reading from file tmpfile_stdout 14:35:54 INFO - Output received: 14:35:54 INFO - Usage: mozinstall [options] installer 14:35:54 INFO - Options: 14:35:54 INFO - -h, --help show this help message and exit 14:35:54 INFO - -d DEST, --destination=DEST 14:35:54 INFO - Directory to install application into. [default: 14:35:54 INFO - "/builds/slave/test"] 14:35:54 INFO - --app=APP Application being installed. [default: firefox] 14:35:54 INFO - mkdir: /builds/slave/test/build/application 14:35:54 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'] 14:35:54 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 14:36:10 INFO - Reading from file tmpfile_stdout 14:36:10 INFO - Output received: 14:36:10 INFO - /builds/slave/test/build/application/firefox/firefox 14:36:10 INFO - Running post-action listener: _resource_record_post_action 14:36:10 INFO - [mozharness: 2016-08-11 21:36:10.899342Z] Finished install step (success) 14:36:10 INFO - [mozharness: 2016-08-11 21:36:10.899591Z] Running run-tests step. 14:36:10 INFO - Running pre-action listener: _resource_record_pre_action 14:36:10 INFO - Running main action method: run_tests 14:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:36:10 INFO - Python 2.7.3 14:36:10 INFO - Return code: 0 14:36:10 INFO - grabbing minidump binary from tooltool 14:36:10 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')]} 14:36:10 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 0x2106570>, '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 0x2107470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2107900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:36:10 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 14:36:10 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 14:36:10 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 14:36:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:36:10 INFO - Return code: 0 14:36:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:36:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:36:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:36:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:36:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 14:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 14:36:10 INFO - Using env: {'DISPLAY': ':0', 14:36:10 INFO - 'HOME': '/home/cltbld', 14:36:10 INFO - 'LANG': 'en_US.UTF-8', 14:36:10 INFO - 'LANGUAGE': 'en_US:en', 14:36:10 INFO - 'LOGNAME': 'cltbld', 14:36:10 INFO - 'MAIL': '/var/mail/cltbld', 14:36:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:36:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:10 INFO - 'MOZ_NO_REMOTE': '1', 14:36:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:10 INFO - 'NO_EM_RESTART': '1', 14:36:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:10 INFO - 'PWD': '/builds/slave/test', 14:36:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:36:10 INFO - 'SHELL': '/bin/bash', 14:36:10 INFO - 'SHLVL': '1', 14:36:10 INFO - 'TERM': 'linux', 14:36:10 INFO - 'TMOUT': '86400', 14:36:10 INFO - 'USER': 'cltbld', 14:36:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406', 14:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:10 INFO - '_': '/tools/buildbot/bin/python'} 14:36:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 14:36:11 INFO - mozversion application_buildid: 20160811130435 14:36:11 INFO - mozversion application_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 14:36:11 INFO - mozversion application_display_name: Nightly 14:36:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:36:11 INFO - mozversion application_name: Firefox 14:36:11 INFO - mozversion application_remotingname: firefox 14:36:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:36:11 INFO - mozversion application_vendor: Mozilla 14:36:11 INFO - mozversion application_version: 51.0a1 14:36:11 INFO - mozversion platform_buildid: 20160811130435 14:36:11 INFO - mozversion platform_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 14:36:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:36:11 INFO - mozversion platform_version: 51.0a1 14:36:11 INFO - using testdate: 1470951371 14:36:11 INFO - actual date: 1470951371 14:36:11 INFO - starting webserver on 'localhost:36713' 14:36:11 INFO - SUITE-START | Running 2 tests 14:36:11 INFO - TEST-START | dromaeo_css 14:36:11 INFO - operating with platform_type : linux_ 14:36:11 INFO - Initialising browser for dromaeo_css test... 14:36:11 INFO - TEST-INFO | started process 4233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnsKFCD/profile http://localhost:36713/getInfo.html) 14:36:16 INFO - PROCESS | 4233 | __metrics Screen width/height:1600/1200 14:36:16 INFO - PROCESS | 4233 | colorDepth:24 14:36:16 INFO - PROCESS | 4233 | Browser inner width/height: 1024/697 14:36:16 INFO - PROCESS | 4233 | __metrics 14:36:16 ERROR - PROCESS | 4233 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 14:36:17 INFO - TEST-INFO | 4233: exit 0 14:36:17 INFO - Browser initialized. 14:36:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:36:17 INFO - TEST-INFO | started process 4354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnsKFCD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:29 INFO - PROCESS | 4354 | RSS: Main: 164200448 14:36:29 INFO - PROCESS | 4354 | 14:37:19 INFO - PROCESS | 4354 | 1470951439384 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] 14:39:32 INFO - PROCESS | 4354 | Cycle 1(1): loaded http://localhost:36713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36713/tests/dromaeo/cssquery-ext.html) 14:39:33 INFO - PROCESS | 4354 | RSS: Main: 166260736 14:39:33 INFO - PROCESS | 4354 | 14:42:35 INFO - PROCESS | 4354 | Cycle 1(1): loaded http://localhost:36713/tests/dromaeo/cssquery-ext.html (next: http://localhost:36713/tests/dromaeo/cssquery-jquery.html) 14:42:36 INFO - PROCESS | 4354 | RSS: Main: 165949440 14:42:36 INFO - PROCESS | 4354 | 14:45:38 INFO - PROCESS | 4354 | Cycle 1(1): loaded http://localhost:36713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36713/tests/dromaeo/cssquery-mootools.html) 14:45:38 INFO - PROCESS | 4354 | RSS: Main: 168820736 14:45:38 INFO - PROCESS | 4354 | 14:48:40 INFO - PROCESS | 4354 | Cycle 1(1): loaded http://localhost:36713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36713/tests/dromaeo/cssquery-prototype.html) 14:48:41 INFO - PROCESS | 4354 | RSS: Main: 163373056 14:48:41 INFO - PROCESS | 4354 | 14:51:44 INFO - PROCESS | 4354 | Cycle 1(1): loaded http://localhost:36713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36713/tests/dromaeo/cssquery-yui.html) 14:51:44 INFO - PROCESS | 4354 | RSS: Main: 165249024 14:51:44 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | Cycle 1(1): loaded http://localhost:36713/tests/dromaeo/cssquery-yui.html (next: http://localhost:36713/tests/dromaeo/cssquery-dojo.html) 14:54:47 INFO - PROCESS | 4354 | RSS: Main: 169668608 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | __start_tp_report 14:54:47 INFO - PROCESS | 4354 | _x_x_mozilla_page_load 14:54:47 INFO - PROCESS | 4354 | _x_x_mozilla_page_load_details 14:54:47 INFO - PROCESS | 4354 | |i|pagename|runs| 14:54:47 INFO - PROCESS | 4354 | |0;dojo.html;2663.5605125154348;2672.5991101334785;2693.434378780456;2695.0432596428273;2717.592361145828;4687.976560117195;4816.229403295473;4835.709857408558;4852.975735121324;4873.585745211662;4734.313524538939;4777;4811.470738218802;4831.806727730886;4832.178529649959;4417.11657668466;4434.201843668138;4508.39136716544;4516.16450956574;4577.954220457803;4475.597196252336;4500.729956202622;4552.704074235181;4557.817687292504;4586.495485496593;4455.2871540553515;4621.4685311189305;4625.560571745696;4626.606738427221;4643.024964757405;4248.936265956013;4458.77706114693;4558.8860278492975;4587.61005314547;4601.815927362902;4335.6965012449145;4382.956170438287;4387.100644367897;4471.977640111779;4551.431071116111;4830.758462076918;4838.274258861164;4840.249761286971;4845.3216549683075;4870.439899411577;5172.948270517284;5201.5838732901275;5203.583713302926;5224.4775522447835;5241.109011468059;5308.177232528964;5323.494268044529;5330.7334633268565;5338.9466105339225;5371.355437347504;4967.180415231446;4967.602591792612;4970.925436118461;4975.278584605212;5003.024410240041;5095.363079615048;5322.840314790563;5364.22218778275;5386.13821788512;5430.755615997289;5189.506996835295;5200.97399513;5208;5209.6353255272525;5243.239730239094;5286.07493688603;5296.09966305729;5296.3909150447425;5304.257403963448;5351.25082488452;4972.279019542146;5136.383633963948;5168.715720635326;5203.479652034766;5236.319278493771;4994.425641051253;5110.693358398508;5143.7685304161405;5167.3799144102195;5179.249008893765;4385.101054283864;4393.7363758174615;4394.099209662011;4413.426254586947;4450.3991961085485;3734.7198960078103;3807.352750032446;3854.5374555053013;3866.5940076292145;3885.436611691289;4542.318652202196;4603.125406172817;4603.401557797465;4629.86110416688;4644.883877903079;5301.787928482895;5317.229001794718;5326.893462130735;5327.280817089721;5334.413214546396;4321.632661223768;4517.6160026397465;4576.542345765463;4598.885027874263;4639.512851150648;4672.906541869143;4691.3432119503295;4749.881252968635;4755.262934245197;4755.928661070017;4977.800887964513;4995.25071239317;4999.550040496373;5024.42219144803;5034.917492739079;5000.849974500771;5198.714070726146;5279.340082489689;5283.2075188722;5337.066013447554;4925.285833554186;4956.801727930842;4974.054929563371;4978.950210497994;4992.675476094042;5177.145770947752;5188.948110518846;5210.452902445189;5220.608454365862;5259.053370393366;4996.225585034325;5080.517350851663;5261.605379596469;5273.393559740679;5280.683159010318;4992.8751781205765;5012.749362531786;5038.294638750651;5110.565601923878;5121.436641969455;5144.125498665161;5151.613628977767;5154.226865970135;5163.715995620277;5165.121929271958;4815.374001379798;5004.674696144739;5046.041252162077;5053.469385714447;5116.590672746246;5079.441261461162;5115.56517696;5124.410692770379;5161.509656582619;5213.713245771367;5010.799568017384;5025.120603894231;5026.3214466048075;5045.091883460866;5052.69683818972 14:54:47 INFO - PROCESS | 4354 | |1;ext.html;546.5600191845564;549.3298176225004;550.6723499517791;560.6019725994545;561.8286422641096;28572.428551428984;37633.81183094084;39379.21241575167;39561.802190989074;43451.78274108625;41061.58938410615;41416;41575.79212103943;41596.79201603995;41774;7492.550446973185;7664.770056898302;7692.730754423596;7703.037120359955;7721.112072111695;7554.320111189992;7659.004329437165;7681;7692.7692169235015;7715.72994945177;7686.615669216545;7690.961545192266;7699.615019249043;7714.8457030859345;7747.883781743279;7667.923320766777;7699.076110866704;7700.268474494914;7727.72952946647;7754.224577542257;7538.886916696254;7579.545227286325;7617.542947423172;7630.122535908386;7636.923630763677;37246.06884827874;37425.25149497022;37486.81256593727;37598;37645.62354376449;3072.2626569623353;3235.8058516489086;3395.303962687643;3644.4351125575577;3821.197548514815;27733.722662773314;28211.85894070537;29449.85275073611;29689;30552.388952221052;3457.7060949819297;3509.0700964244243;3541.929161416783;3545.982270088659;3578.2306804037;258021;261745;262972;263171;265415;32100.83949580237;51789.7410512945;52444.737776310874;52537;52584.21123683148;32253.51619725706;33990.32019359599;34004.1498962523;34133.146671333416;34211.14472138217;13574.389152487964;13736.93131534336;13754.862451375559;13801.240931748851;13808.516701915585;10839.783204335869;10846.783064338826;10874.945625271981;10885.401302928414;10903.29128606638;7916.485428447248;7955.24425179607;7982.920170798217;7997.480163789335;8100.675972961133;3162;3189.792663476913;3189.8086114833186;3253.7071663550396;3295.143262751702;865.3639574912435;891.0106592382592;906.428949761646;997.9770734996687;1023.6059117239917;26851.194464166107;27121.9783604406;27711.584326235123;27955.30111747182;28331.858340708164;863.9092895245909;953.0802775321848;957.7988622389377;966.8308046091905;994.1202036198017;14358.138511689333;14398.85601143996;14474.986750927334;14756.631084222765;14971.40114395412;385525;391129;393349;396068;397440;49899;49994;50017;50036.74981625069;50073.24890126651;1178.7642471505733;1200.2678366196612;1215.5745489078752;1216.8722284160212;1231.347385885482;25350.619740704275;25908.22275331743;27691;28091.578626320214;28132.156035318974;42194;42712.35931460968;43026.569734302255;43079.56920430881;43122.568774311854;356958;359407;361276;361401;361541;25570;25771.306839342255;25894.611580825927;25932.740672593034;26010.86994565015;41598.168036639705;41766;42186.78906605447;42240.15519689651;42320.36519452149;35229.64770352366;35654;36065.09837253985;36324.27351453009;36820.263594728494;35392.64607353997;35583.82208088943;35873.103172420895;36098.63901360953;36668.083297917765;35216.471752923215;35341.82329088338;35444;35731;36738.8163059183;31061.53407698841;32448.188795280308;32798.18004549905;32883.177920552174;33033.50449743304;24981;25120.62319065179;25342.366440839127;25419.491610168065;25445.745542544337 14:54:47 INFO - PROCESS | 4354 | |2;jquery.html;343.16268305334995;356.90006798096533;359.9316129935312;369.8150924537731;377.89796754876187;15676.529704108882;16010.119443430607;16668.333266669335;17202.053887036207;17317.39389121378;13554.39005244764;17297.740533892003;17298.56753581161;17310.56723581911;17412.912935435335;4858.927116093261;5077.59379249661;5091.745412729368;5096.949030509684;5103.5917126629965;5019.447860735316;5098.9745051274695;5102.1836506159025;5123.641345105844;5125.077486052509;6208.286047104596;6557.967210163943;6588.571742836701;6605.174353205849;6699.229588597325;6558.409743123118;6724.823155947714;6757.628330441824;6761.9323806761795;6762;6492.318306577836;6614.735410583571;6707.899381509281;6716.026176204472;6776.627285499296;23526;23607.527849442915;23663.526729465488;24210.63684044741;24380;1952.453313072342;2117.6400011998;2160.7515135759277;2206.3711842125076;2594.4292255703713;14486.782698259534;14553.563393098118;14670;14699.779503307458;15160.469383571632;1863.5900101977543;1893.9242430302772;1894.9242030318771;1947.094601010537;1977.0114942528735;79936.60031699804;80728.19271807325;80984.59507702483;81421;81680;15740.527784166494;16139.435119770751;16729.83270167307;16735.414260500824;16957.98252104853;28239.858800705864;28285.858570707016;28307;28322.43355132927;28613.71386286152;8721;8839.204471597586;8945.15021072997;9122.498262595622;9253.306002049872;7268.709251629875;7340.0457940467395;7356.926430735624;7541.47209695327;7544.3210111089165;8126.349892008625;8431.494110353398;8475.74572762818;8550;8738.257248133852;3215.1962009497624;3401.3707464119216;3451.361498122855;3509.4034014217646;3516.1385460561814;784.5920121536769;799.3365506629484;887.8845750052452;906.410832958569;939.5396255834592;15834.683306333809;16225.51323460298;17617.647647046986;17649.1323883522;17788.57691384686;826.8925039744795;836.1387770596295;884.5930871799045;888.1651247827022;904.0552622509493;7212.531185473033;9751.3661611995;9826.901730982741;9903.306768526134;9928.801423971625;286186;290068;389005;391943.52367096045;393634;77467.61266193633;79292;80303;80532;83587.16412835916;914.8444764390202;925.2921515040999;928.7074571509953;928.9303302252358;932.7854593443546;14507.1295722257;15050.623734406727;16574.419895303607;16870.831291686925;17032.48902532926;29592.96424625128;30202;35608;38725.80637096796;39511;49212.2618160735;51187;53681;53739.73130134324;53939.190912137135;6367.26776420699;6764.729410823512;6868.244493105654;6952.513324067267;7207.315305046012;8245.546494942595;11297.71755706114;11577.552805899262;11745.706357341134;12721.681957951125;10540.420276884844;10759.623413180501;10994.065504432212;11048.281861678965;11146.944265278622;10823.891761082288;10905.672829815117;10973;11023.283486573348;11120.277181983469;10941;10982;11028.22802403824;11217.775644487228;11277.097832173571;7166.641667916688;7433.256674332523;7513.060867391576;7711.8843217352905;8081.757547273592;10722.410267435365;10804.513796879002;10810.027097561257;10818.809930907752;10985.670429887115 14:54:47 INFO - PROCESS | 4354 | |3;mootools.html;1359.5853264754246;1402.060619385012;1484.7698606715956;1651.9008859468424;1696.5758560359902;6533.216014078305;7199.496035277532;7362.226966168556;7773.533587984718;7784.961075194623;7469.327760501554;7710.768676939687;7712.961435192816;7724.150343462229;7727.111382191049;2116.492041909946;2158.0720290275176;2165.9783402165936;2166.057764872278;2168.934931952044;2097.842661800371;2126.9893650531726;2136.327056977047;2146.5384942237415;2152.1391443422676;2156.3638726575696;2158.881261530615;2160.8487405881597;2163.5456554123575;2198.7581366049803;2089.5925294567564;2096.549241912981;2096.559722458278;2096.7798381169987;2100.9159633614636;2025.3518873960338;2106.452322396188;2122.395117391536;2137.1237792505;2140.4113868686236;7764.495307805031;7813.218678132198;7836.138024817265;7873.842523149505;7876.684932602689;4370.2789039808395;4465.129299786543;4512.413386259798;4518.615917647004;4523.660725445572;2824.7316504932;2860.2706309890846;2895.7683385329124;2931.4430258250864;2933.1933718227447;901.589776651622;939.3518472254123;941.3786900645609;941.9764505887408;943.5942544705774;10518.684439466904;10524.31591946521;10545.84181237282;10565.73585660357;10568.630097946612;3774.245150969817;3905.258000979805;4046.716729828943;4071.776052317151;4077.204945035749;8932.821343573092;8936.195742383217;8951.283897288331;8971.192592666692;8988.235999940078;4498.987727761293;4531.524189960072;4534.79593418297;4543.522930092293;4545.272756359032;3425.53755243044;3908.921821563553;3995.700322475826;4112.588741125924;4114.382842573578;3607.152319204985;3610.808433217032;3672.57765356982;3687.9262414751556;3855.749376290532;1172.0974849366112;1172.695099274195;1185.4428418643224;1186.0371085852928;1186.5253898440692;752.2327226229215;758.2493331601675;805.6374631415887;805.6938363421863;829.9087100418949;4970.378702662168;4989.451160372356;4998.925016124761;5089.491050894881;5144;360.9747317687789;363.208206110676;365.89389077167857;368.8874893157613;379.46495441427453;3479.2519608283833;3492.5634295713035;3507.649235076472;3530.894073177809;3624.3294990426857;9078.773030674285;9420.62317507292;9533.570989305497;9543.570539325747;9551.331406801457;9496.09787070241;9496.905030949601;9580.473073980998;9592.76018099553;9609.663661771805;7260.346568808727;7265.745698900513;7312.232215617496;7324.974503569504;7343.192248852729;4993.625478089085;5114.33513643224;5182.6890386575415;5319.175527793198;5361.62468627208;8586.398952073296;8591.613377398156;8804.955975220082;8875.689350872688;8891.555422228992;8413.537255451009;8571.40000200005;8603.311735061305;8836.204741573289;8847.911520884967;5649.406812284651;6554;6570.967145164434;6663.36698013688;6786.151731033621;7487.251274872469;7561.4706970513735;7564.092308922965;7571.697132114654;7575.545467271982;6521.217453905561;6638.90041649366;6708.6310252936555;6786.966065169642;6864.073350097673;6579.243387010363;6660.533762636569;6704.128463299739;6831.521793474409;6956.478264130109;6072.514198863992;6160.599561028519;6168.9691551541955;6171.537134715004;6172.321044684992;4477.641788656834;4542.250528662866;4550.408446901882;4613.123506533748;4699.365585645894;4453.955460445354;4557.1797076526545;4623.329617205553;4633.235516139799;4750.12122757291 14:54:47 INFO - PROCESS | 4354 | |4;prototype.html;288.1786907314156;291.2151751030971;299.4744223887078;300.1655397993578;305.40141323006907;4900.754962251891;4989.550940415362;5037.916847877706;5124.8975020499565;5130.486951304868;4993.675411098285;5021.221710634848;5025.7487125643665;5031.547160755531;5059.822906198284;3975.9801200993957;3996;4000.8599699010542;4010.278149933011;4015.7791321477307;3855.8650447234354;3997.680185585161;4012.4382586437923;4013.779242141681;4022.8189731462153;3930.272899513599;3935.8032098394965;3956.4263181838614;3956.9010774730573;3970.7617542947514;3951.881443556698;3955.624215699504;3958.703097267702;3962.5046869141356;3975.662068724162;3510;3519.2081781598936;3524.22467057247;3533.5406397168463;3548.964510354889;4862.027594481083;4896.559309662111;4927.753612319406;4969.503049695038;5000.89998200034;4515.245700122922;4534.614557762594;4547.5452454754595;4566.292224705143;4581.289900065495;5272.604554658416;5282.815101471469;5292.550133238679;5293.100172970604;5312.814051508218;3696.537932758405;3786.7314449659398;3810.5998870118515;3825.2158307547165;3848.2111167210655;5488.807891723811;5499.642523235977;5513.173024046385;5516.586256030814;5596.3284405871145;3910.9022274442796;3924.156306394139;3945.3292940200236;3955.1891862168186;3959.6436320731273;3823.3500304948225;3959.891230455477;4007.1584967157223;4007.6192761687594;4011.618896204856;4463.464384273908;4464.888377790581;4482.596566309048;4494.662900282492;4525.456945166601;5270.209468579667;5324;5330.200469929541;5335.413104558495;5348.91976620351;1293.9676508087373;1321.6387121265113;1340.604521666111;1353.8375394952668;1354.1739538881275;904.3895370624933;913.5428990759727;950.2018304624149;950.2018304624149;950.6197520991659;4597.218472859622;4613.976930115395;4632.69887457321;4633.617459254763;4633.9536604634195;5382.703951282717;5398.865028374322;5400.810971615974;5404.621676482609;5405.162199859028;4443.422355093817;4603.148417542765;4608.470025946992;4616.192166370872;4649.697769644962;2490.1284550407577;2490.638857365672;2515.132279363617;2526.5199612074016;2535.378832186126;4454.933176002362;4489.32660100981;4512.954870451319;4522.841700540465;4543;4556.908861822812;4823.686460380064;4829.782659780319;4837.95162048382;4854.417469903564;4367.100311364567;4425.84509542171;4431.290993441098;4458.2420988431395;4467.486239082482;4730.550597693214;4737.265723812815;4758.952410475851;4784.497627749036;4788.569028787426;4619.745913974763;4643.651726120487;4648.930266045944;4656.93014604788;4664.930026049544;4734.21885388907;5058.494150584912;5089.684193691935;5101.7194054327365;5129.384473863011;3778.3576791944884;3785.6782173515558;3795.867144649924;3810.7332486725663;3855.51806024247;5235.554977826928;5518.586106042143;5519.806806761744;5526.143447765603;5532.695701736443;5140.46025167367;5225.085610018155;5242.659227150223;5251.973740131275;5261.973690131525;5228.37259528859;5244.688827793052;5248.265242865926;5299.311089558333;5302.496262855023;5052.72210028452;5150.248915368793;5154.716490593053;5185.948140518546;5188.195829646411;5267.157254839208;5275.551578115903;5302.284191634234;5337.452138879837;5342.1452567589;5173.163526947879;5189.299444574934;5195.610329225247;5210.7494201392155;5221.399539053057 14:54:47 INFO - PROCESS | 4354 | |5;yui.html;647.5305403582404;671.2213831954933;715.8174665460307;722.2452537098732;750.8723517002111;13186.472541098357;14197.361118749655;14288.428462861486;14315.141091534515;15138.772918406205;14842.406303747865;14978.850211497882;15042.323095460702;15047.77428338573;15116;758.037292638349;780.2821404308022;784.3333166808225;785.7367781793077;788.420510924473;629.5813284166024;749.2470067582072;766.6281853301144;772.0195351903079;778.7235531386361;803.236924921327;804.5936801915025;810.4448452809814;811.8863359129726;813.2639960835423;796.928276455116;799.2327365728908;801.3789313282194;802.7471346525855;805.138501803071;585.4613755345093;588.3880764005429;589.1545632018068;589.7051474262869;592.7806711516766;13703.725925481534;13718.176909385369;13739.656508587266;13757.862421375758;13824.170549767046;12540.874591254062;13090.672733181651;13694.726105477934;13719.245441500714;13840.377183026789;10709.410982395964;10998.725031874266;11141.331520108819;11176.552937882476;11255.887441125566;3311.9503207451667;3360.1263671445354;3366.074329559366;3390.9491357629654;3490.441529355291;68157.65921170362;68408.31591684069;68923.31076689219;69555;69588.65205673939;9926.900730992742;10186.898131018595;10268.486575671335;10341.63804266847;10359.63741269052;18684.532886677942;18697.719534206997;18823.247070117315;19049.80950190508;19081.809181908004;6809.216940051859;7052.682629281695;7132.821679458055;7372.815679607946;7511.173770885308;3787.2614840106467;3825.12022234882;3864.4976153099915;3866.130120722815;3906.8632597859505;2608.5174242765147;2670.6661667291587;2698.5007773561956;2705.702372738997;2739.8630068496495;485.6915858429852;487.6342742942793;488.2773495227013;504.399764280505;514.3698968763235;495.6109454078603;522.7778194267421;584.1763114009227;616.1897105306508;653.323809856796;8256.504609723435;8707.129287071242;8763.25512331459;8897.421667591585;8918.73243802687;498.99002019959397;516.51963673783;523.1316015414394;598.9281286245591;611.0803241122082;3953.6639385652543;4125.546189919107;4187.539370669285;4267.551907049778;4269.87190384289;79376.60311698404;95064.14807555784;96015.51992239994;97705;97774.51112744391;46306;46549;47073.29390059152;47590.28614570784;81850.18149818426;70635;70797;71492.64253678698;73271.99999999894;74802.25197748061;7620.466567340454;7734.701729315437;7862.60686965638;7878.566678832719;7936.2857342839425;44015.55984440115;44077.55922440735;44622.77688611536;44812.77593612011;45050;57003.714981424826;60331.69834150801;65516.34483655103;65728.34271657222;68529.3147068523;9698.854517182106;9813.460259685786;10047.497625118569;10213.285070045322;10317.896821031694;11076.280041797258;11184.406901080558;11254.7749045017;11335.943320283346;11624.360660163435;10689.091427228772;10828;10892.945535272273;11032.944835275772;11086.113110951266;10760.784784304113;10779.299345542515;10858.891411085788;10922.781544369227;11011.339319640847;10355.792884142425;10515.106215971728;10904.182186335898;11540.711482213012;11768.52925882955;9929.35459195179;9977.551010204414;10099.545520451451;10644.89355106439;10750.408727520062;9107.908920910706;9518.857217141609;9713.980032096528;9817.950910245403;9818.65634702782 14:54:47 INFO - PROCESS | 4354 | __end_tp_report 14:54:47 INFO - PROCESS | 4354 | __start_cc_report 14:54:47 INFO - PROCESS | 4354 | _x_x_mozilla_cycle_collect,366 14:54:47 INFO - PROCESS | 4354 | __end_cc_report 14:54:47 INFO - PROCESS | 4354 | __startTimestamp1470952487819__endTimestamp 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | ------- Summary: start ------- 14:54:47 INFO - PROCESS | 4354 | Number of tests: 6 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | [#0] dojo.html Cycles:165 Average:4839.10 Median:4992.88 stddev:518.87 (10.4%) stddev-sans-first:491.60 14:54:47 INFO - PROCESS | 4354 | Values: 2663.6 2672.6 2693.4 2695.0 2717.6 4688.0 4816.2 4835.7 4853.0 4873.6 4734.3 4777.0 4811.5 4831.8 4832.2 4417.1 4434.2 4508.4 4516.2 4578.0 4475.6 4500.7 4552.7 4557.8 4586.5 4455.3 4621.5 4625.6 4626.6 4643.0 4248.9 4458.8 4558.9 4587.6 4601.8 4335.7 4383.0 4387.1 4472.0 4551.4 4830.8 4838.3 4840.2 4845.3 4870.4 5172.9 5201.6 5203.6 5224.5 5241.1 5308.2 5323.5 5330.7 5338.9 5371.4 4967.2 4967.6 4970.9 4975.3 5003.0 5095.4 5322.8 5364.2 5386.1 5430.8 5189.5 5201.0 5208.0 5209.6 5243.2 5286.1 5296.1 5296.4 5304.3 5351.3 4972.3 5136.4 5168.7 5203.5 5236.3 4994.4 5110.7 5143.8 5167.4 5179.2 4385.1 4393.7 4394.1 4413.4 4450.4 3734.7 3807.4 3854.5 3866.6 3885.4 4542.3 4603.1 4603.4 4629.9 4644.9 5301.8 5317.2 5326.9 5327.3 5334.4 4321.6 4517.6 4576.5 4598.9 4639.5 4672.9 4691.3 4749.9 4755.3 4755.9 4977.8 4995.3 4999.6 5024.4 5034.9 5000.8 5198.7 5279.3 5283.2 5337.1 4925.3 4956.8 4974.1 4979.0 4992.7 5177.1 5188.9 5210.5 5220.6 5259.1 4996.2 5080.5 5261.6 5273.4 5280.7 4992.9 5012.7 5038.3 5110.6 5121.4 5144.1 5151.6 5154.2 5163.7 5165.1 4815.4 5004.7 5046.0 5053.5 5116.6 5079.4 5115.6 5124.4 5161.5 5213.7 5010.8 5025.1 5026.3 5045.1 5052.7 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | [#1] ext.html Cycles:180 Average:47858.71 Median:361471.00 stddev:90612.72 (25.1%) stddev-sans-first:90797.28 14:54:47 INFO - PROCESS | 4354 | Values: 546.6 549.3 550.7 560.6 561.8 28572.4 37633.8 39379.2 39561.8 43451.8 41061.6 41416.0 41575.8 41596.8 41774.0 7492.6 7664.8 7692.7 7703.0 7721.1 7554.3 7659.0 7681.0 7692.8 7715.7 7686.6 7691.0 7699.6 7714.8 7747.9 7667.9 7699.1 7700.3 7727.7 7754.2 7538.9 7579.5 7617.5 7630.1 7636.9 37246.1 37425.3 37486.8 37598.0 37645.6 3072.3 3235.8 3395.3 3644.4 3821.2 27733.7 28211.9 29449.9 29689.0 30552.4 3457.7 3509.1 3541.9 3546.0 3578.2 258021.0 261745.0 262972.0 263171.0 265415.0 32100.8 51789.7 52444.7 52537.0 52584.2 32253.5 33990.3 34004.1 34133.1 34211.1 13574.4 13736.9 13754.9 13801.2 13808.5 10839.8 10846.8 10874.9 10885.4 10903.3 7916.5 7955.2 7982.9 7997.5 8100.7 3162.0 3189.8 3189.8 3253.7 3295.1 865.4 891.0 906.4 998.0 1023.6 26851.2 27122.0 27711.6 27955.3 28331.9 863.9 953.1 957.8 966.8 994.1 14358.1 14398.9 14475.0 14756.6 14971.4 385525.0 391129.0 393349.0 396068.0 397440.0 49899.0 49994.0 50017.0 50036.7 50073.2 1178.8 1200.3 1215.6 1216.9 1231.3 25350.6 25908.2 27691.0 28091.6 28132.2 42194.0 42712.4 43026.6 43079.6 43122.6 356958.0 359407.0 361276.0 361401.0 361541.0 25570.0 25771.3 25894.6 25932.7 26010.9 41598.2 41766.0 42186.8 42240.2 42320.4 35229.6 35654.0 36065.1 36324.3 36820.3 35392.6 35583.8 35873.1 36098.6 36668.1 35216.5 35341.8 35444.0 35731.0 36738.8 31061.5 32448.2 32798.2 32883.2 33033.5 24981.0 25120.6 25342.4 25419.5 25445.7 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | [#2] jquery.html Cycles:180 Average:24781.00 Median:390474.26 stddev:58904.11 (15.1%) stddev-sans-first:59040.77 14:54:47 INFO - PROCESS | 4354 | Values: 343.2 356.9 359.9 369.8 377.9 15676.5 16010.1 16668.3 17202.1 17317.4 13554.4 17297.7 17298.6 17310.6 17412.9 4858.9 5077.6 5091.7 5096.9 5103.6 5019.4 5099.0 5102.2 5123.6 5125.1 6208.3 6558.0 6588.6 6605.2 6699.2 6558.4 6724.8 6757.6 6761.9 6762.0 6492.3 6614.7 6707.9 6716.0 6776.6 23526.0 23607.5 23663.5 24210.6 24380.0 1952.5 2117.6 2160.8 2206.4 2594.4 14486.8 14553.6 14670.0 14699.8 15160.5 1863.6 1893.9 1894.9 1947.1 1977.0 79936.6 80728.2 80984.6 81421.0 81680.0 15740.5 16139.4 16729.8 16735.4 16958.0 28239.9 28285.9 28307.0 28322.4 28613.7 8721.0 8839.2 8945.2 9122.5 9253.3 7268.7 7340.0 7356.9 7541.5 7544.3 8126.3 8431.5 8475.7 8550.0 8738.3 3215.2 3401.4 3451.4 3509.4 3516.1 784.6 799.3 887.9 906.4 939.5 15834.7 16225.5 17617.6 17649.1 17788.6 826.9 836.1 884.6 888.2 904.1 7212.5 9751.4 9826.9 9903.3 9928.8 286186.0 290068.0 389005.0 391943.5 393634.0 77467.6 79292.0 80303.0 80532.0 83587.2 914.8 925.3 928.7 928.9 932.8 14507.1 15050.6 16574.4 16870.8 17032.5 29593.0 30202.0 35608.0 38725.8 39511.0 49212.3 51187.0 53681.0 53739.7 53939.2 6367.3 6764.7 6868.2 6952.5 7207.3 8245.5 11297.7 11577.6 11745.7 12721.7 10540.4 10759.6 10994.1 11048.3 11146.9 10823.9 10905.7 10973.0 11023.3 11120.3 10941.0 10982.0 11028.2 11217.8 11277.1 7166.6 7433.3 7513.1 7711.9 8081.8 10722.4 10804.5 10810.0 10818.8 10985.7 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | [#3] mootools.html Cycles:180 Average:5040.98 Median:4979.91 stddev:2853.58 (57.3%) stddev-sans-first:2848.18 14:54:47 INFO - PROCESS | 4354 | Values: 1359.6 1402.1 1484.8 1651.9 1696.6 6533.2 7199.5 7362.2 7773.5 7785.0 7469.3 7710.8 7713.0 7724.2 7727.1 2116.5 2158.1 2166.0 2166.1 2168.9 2097.8 2127.0 2136.3 2146.5 2152.1 2156.4 2158.9 2160.8 2163.5 2198.8 2089.6 2096.5 2096.6 2096.8 2100.9 2025.4 2106.5 2122.4 2137.1 2140.4 7764.5 7813.2 7836.1 7873.8 7876.7 4370.3 4465.1 4512.4 4518.6 4523.7 2824.7 2860.3 2895.8 2931.4 2933.2 901.6 939.4 941.4 942.0 943.6 10518.7 10524.3 10545.8 10565.7 10568.6 3774.2 3905.3 4046.7 4071.8 4077.2 8932.8 8936.2 8951.3 8971.2 8988.2 4499.0 4531.5 4534.8 4543.5 4545.3 3425.5 3908.9 3995.7 4112.6 4114.4 3607.2 3610.8 3672.6 3687.9 3855.7 1172.1 1172.7 1185.4 1186.0 1186.5 752.2 758.2 805.6 805.7 829.9 4970.4 4989.5 4998.9 5089.5 5144.0 361.0 363.2 365.9 368.9 379.5 3479.3 3492.6 3507.6 3530.9 3624.3 9078.8 9420.6 9533.6 9543.6 9551.3 9496.1 9496.9 9580.5 9592.8 9609.7 7260.3 7265.7 7312.2 7325.0 7343.2 4993.6 5114.3 5182.7 5319.2 5361.6 8586.4 8591.6 8805.0 8875.7 8891.6 8413.5 8571.4 8603.3 8836.2 8847.9 5649.4 6554.0 6571.0 6663.4 6786.2 7487.3 7561.5 7564.1 7571.7 7575.5 6521.2 6638.9 6708.6 6787.0 6864.1 6579.2 6660.5 6704.1 6831.5 6956.5 6072.5 6160.6 6169.0 6171.5 6172.3 4477.6 4542.3 4550.4 4613.1 4699.4 4454.0 4557.2 4623.3 4633.2 4750.1 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | [#4] prototype.html Cycles:180 Average:4292.02 Median:4638.80 stddev:1234.07 (26.6%) stddev-sans-first:1200.38 14:54:47 INFO - PROCESS | 4354 | Values: 288.2 291.2 299.5 300.2 305.4 4900.8 4989.6 5037.9 5124.9 5130.5 4993.7 5021.2 5025.7 5031.5 5059.8 3976.0 3996.0 4000.9 4010.3 4015.8 3855.9 3997.7 4012.4 4013.8 4022.8 3930.3 3935.8 3956.4 3956.9 3970.8 3951.9 3955.6 3958.7 3962.5 3975.7 3510.0 3519.2 3524.2 3533.5 3549.0 4862.0 4896.6 4927.8 4969.5 5000.9 4515.2 4534.6 4547.5 4566.3 4581.3 5272.6 5282.8 5292.6 5293.1 5312.8 3696.5 3786.7 3810.6 3825.2 3848.2 5488.8 5499.6 5513.2 5516.6 5596.3 3910.9 3924.2 3945.3 3955.2 3959.6 3823.4 3959.9 4007.2 4007.6 4011.6 4463.5 4464.9 4482.6 4494.7 4525.5 5270.2 5324.0 5330.2 5335.4 5348.9 1294.0 1321.6 1340.6 1353.8 1354.2 904.4 913.5 950.2 950.2 950.6 4597.2 4614.0 4632.7 4633.6 4634.0 5382.7 5398.9 5400.8 5404.6 5405.2 4443.4 4603.1 4608.5 4616.2 4649.7 2490.1 2490.6 2515.1 2526.5 2535.4 4454.9 4489.3 4513.0 4522.8 4543.0 4556.9 4823.7 4829.8 4838.0 4854.4 4367.1 4425.8 4431.3 4458.2 4467.5 4730.6 4737.3 4759.0 4784.5 4788.6 4619.7 4643.7 4648.9 4656.9 4664.9 4734.2 5058.5 5089.7 5101.7 5129.4 3778.4 3785.7 3795.9 3810.7 3855.5 5235.6 5518.6 5519.8 5526.1 5532.7 5140.5 5225.1 5242.7 5252.0 5262.0 5228.4 5244.7 5248.3 5299.3 5302.5 5052.7 5150.2 5154.7 5185.9 5188.2 5267.2 5275.6 5302.3 5337.5 5342.1 5173.2 5189.3 5195.6 5210.7 5221.4 14:54:47 INFO - PROCESS | 4354 | 14:54:47 INFO - PROCESS | 4354 | [#5] yui.html Cycles:180 Average:16955.83 Median:487.96 stddev:23562.48 (4828.8%) stddev-sans-first:23596.75 14:54:47 INFO - PROCESS | 4354 | Values: 647.5 671.2 715.8 722.2 750.9 13186.5 14197.4 14288.4 14315.1 15138.8 14842.4 14978.9 15042.3 15047.8 15116.0 758.0 780.3 784.3 785.7 788.4 629.6 749.2 766.6 772.0 778.7 803.2 804.6 810.4 811.9 813.3 796.9 799.2 801.4 802.7 805.1 585.5 588.4 589.2 589.7 592.8 13703.7 13718.2 13739.7 13757.9 13824.2 12540.9 13090.7 13694.7 13719.2 13840.4 10709.4 10998.7 11141.3 11176.6 11255.9 3312.0 3360.1 3366.1 3390.9 3490.4 68157.7 68408.3 68923.3 69555.0 69588.7 9926.9 10186.9 10268.5 10341.6 10359.6 18684.5 18697.7 18823.2 19049.8 19081.8 6809.2 7052.7 7132.8 7372.8 7511.2 3787.3 3825.1 3864.5 3866.1 3906.9 2608.5 2670.7 2698.5 2705.7 2739.9 485.7 487.6 488.3 504.4 514.4 495.6 522.8 584.2 616.2 653.3 8256.5 8707.1 8763.3 8897.4 8918.7 499.0 516.5 523.1 598.9 611.1 3953.7 4125.5 4187.5 4267.6 4269.9 79376.6 95064.1 96015.5 97705.0 97774.5 46306.0 46549.0 47073.3 47590.3 81850.2 70635.0 70797.0 71492.6 73272.0 74802.3 7620.5 7734.7 7862.6 7878.6 7936.3 44015.6 44077.6 44622.8 44812.8 45050.0 57003.7 60331.7 65516.3 65728.3 68529.3 9698.9 9813.5 10047.5 10213.3 10317.9 11076.3 11184.4 11254.8 11335.9 11624.4 10689.1 10828.0 10892.9 11032.9 11086.1 10760.8 10779.3 10858.9 10922.8 11011.3 10355.8 10515.1 10904.2 11540.7 11768.5 9929.4 9977.6 10099.5 10644.9 10750.4 9107.9 9518.9 9714.0 9818.0 9818.7 14:54:47 INFO - PROCESS | 4354 | -------- Summary: end -------- 14:54:47 INFO - PROCESS | 4354 | 14:54:48 INFO - TEST-INFO | 4354: exit 0 14:54:48 INFO - TEST-OK | dromaeo_css | took 1117491ms 14:54:48 INFO - TEST-START | kraken 14:54:48 INFO - operating with platform_type : linux_ 14:54:48 INFO - Initialising browser for kraken test... 14:54:48 INFO - TEST-INFO | started process 4598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnYlqGU/profile http://localhost:36713/getInfo.html) 14:54:53 INFO - PROCESS | 4598 | __metrics Screen width/height:1600/1200 14:54:53 INFO - PROCESS | 4598 | colorDepth:24 14:54:53 INFO - PROCESS | 4598 | Browser inner width/height: 1024/697 14:54:53 INFO - PROCESS | 4598 | __metrics 14:54:54 ERROR - PROCESS | 4598 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 14:54:55 INFO - TEST-INFO | 4598: exit 0 14:54:55 INFO - Browser initialized. 14:54:55 INFO - Running cycle 1/1 for kraken test... 14:54:55 INFO - TEST-INFO | started process 4719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnYlqGU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:06 INFO - PROCESS | 4719 | RSS: Main: 163631104 14:55:06 INFO - PROCESS | 4719 | 14:55:09 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36713/tests/kraken/driver.html?testName=audio-beat-detection) 14:55:10 INFO - PROCESS | 4719 | RSS: Main: 168656896 14:55:10 INFO - PROCESS | 4719 | 14:55:13 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36713/tests/kraken/driver.html?testName=audio-dft) 14:55:14 INFO - PROCESS | 4719 | RSS: Main: 167976960 14:55:14 INFO - PROCESS | 4719 | 14:55:17 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36713/tests/kraken/driver.html?testName=audio-fft) 14:55:17 INFO - PROCESS | 4719 | RSS: Main: 164229120 14:55:17 INFO - PROCESS | 4719 | 14:55:19 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36713/tests/kraken/driver.html?testName=audio-oscillator) 14:55:20 INFO - PROCESS | 4719 | RSS: Main: 164761600 14:55:20 INFO - PROCESS | 4719 | 14:55:22 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:55:23 INFO - PROCESS | 4719 | RSS: Main: 165208064 14:55:23 INFO - PROCESS | 4719 | 14:55:26 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36713/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:27 INFO - PROCESS | 4719 | RSS: Main: 165294080 14:55:27 INFO - PROCESS | 4719 | 14:55:30 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36713/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:31 INFO - PROCESS | 4719 | RSS: Main: 162217984 14:55:31 INFO - PROCESS | 4719 | 14:55:34 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36713/tests/kraken/driver.html?testName=json-parse-financial) 14:55:35 INFO - PROCESS | 4719 | RSS: Main: 164069376 14:55:35 INFO - PROCESS | 4719 | 14:55:36 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:55:37 INFO - PROCESS | 4719 | RSS: Main: 164139008 14:55:37 INFO - PROCESS | 4719 | 14:55:39 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:55:39 INFO - PROCESS | 4719 | RSS: Main: 164196352 14:55:39 INFO - PROCESS | 4719 | 14:55:42 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:55:42 INFO - PROCESS | 4719 | RSS: Main: 164667392 14:55:42 INFO - PROCESS | 4719 | 14:55:45 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:46 INFO - PROCESS | 4719 | RSS: Main: 165216256 14:55:46 INFO - PROCESS | 4719 | 14:55:49 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:49 INFO - PROCESS | 4719 | RSS: Main: 165650432 14:55:49 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | Cycle 1(1): loaded http://localhost:36713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36713/tests/kraken/driver.html?testName=ai-astar) 14:55:51 INFO - PROCESS | 4719 | RSS: Main: 166248448 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | __start_tp_report 14:55:51 INFO - PROCESS | 4719 | _x_x_mozilla_page_load 14:55:51 INFO - PROCESS | 4719 | _x_x_mozilla_page_load_details 14:55:51 INFO - PROCESS | 4719 | |i|pagename|runs| 14:55:51 INFO - PROCESS | 4719 | |0;ai-astar;106;118;113;116;116;116;115;115;115;115 14:55:51 INFO - PROCESS | 4719 | |1;audio-beat-detection;148;125;144;182;124;162;150;125;183;130 14:55:51 INFO - PROCESS | 4719 | |2;audio-dft;163;164;164;171;162;163;166;164;163;164 14:55:51 INFO - PROCESS | 4719 | |3;audio-fft;78;76;77;173;77;75;76;77;164;76 14:55:51 INFO - PROCESS | 4719 | |4;audio-oscillator;86;85;136;90;86;85;141;84;86;144 14:55:51 INFO - PROCESS | 4719 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;118;120;118 14:55:51 INFO - PROCESS | 4719 | |6;imaging-darkroom;147;147;147;148;148;151;148;149;148;148 14:55:51 INFO - PROCESS | 4719 | |7;imaging-desaturate;96;97;98;96;96;96;96;97;95;95 14:55:51 INFO - PROCESS | 4719 | |8;json-parse-financial;64;64;66;65;65;64;64;68;64;64 14:55:51 INFO - PROCESS | 4719 | |9;json-stringify-tinderbox;71;67;67;67;67;66;66;67;67;66 14:55:51 INFO - PROCESS | 4719 | |10;stanford-crypto-aes;91;88;81;91;86;81;86;91;85;81 14:55:51 INFO - PROCESS | 4719 | |11;stanford-crypto-ccm;142;133;135;136;134;135;150;137;152;145 14:55:51 INFO - PROCESS | 4719 | |12;stanford-crypto-pbkdf2;169;170;169;168;171;170;167;172;170;170 14:55:51 INFO - PROCESS | 4719 | |13;stanford-crypto-sha256-iterative;71;70;72;74;70;72;70;68;69;68 14:55:51 INFO - PROCESS | 4719 | __end_tp_report 14:55:51 INFO - PROCESS | 4719 | __start_cc_report 14:55:51 INFO - PROCESS | 4719 | _x_x_mozilla_cycle_collect,963 14:55:51 INFO - PROCESS | 4719 | __end_cc_report 14:55:51 INFO - PROCESS | 4719 | __startTimestamp1470952551910__endTimestamp 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | ------- Summary: start ------- 14:55:51 INFO - PROCESS | 4719 | Number of tests: 14 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.50 stddev:3.24 (2.8%) stddev-sans-first:1.33 14:55:51 INFO - PROCESS | 4719 | Values: 106.0 118.0 113.0 116.0 116.0 116.0 115.0 115.0 115.0 115.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:149.00 stddev:22.48 (15.1%) stddev-sans-first:23.85 14:55:51 INFO - PROCESS | 4719 | Values: 148.0 125.0 144.0 182.0 124.0 162.0 150.0 125.0 183.0 130.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.55 (1.6%) stddev-sans-first:2.65 14:55:51 INFO - PROCESS | 4719 | Values: 163.0 164.0 164.0 171.0 162.0 163.0 166.0 164.0 163.0 164.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.50 stddev:38.86 (50.8%) stddev-sans-first:40.73 14:55:51 INFO - PROCESS | 4719 | Values: 78.0 76.0 77.0 173.0 77.0 75.0 76.0 77.0 164.0 76.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:85.50 stddev:26.36 (30.8%) stddev-sans-first:27.29 14:55:51 INFO - PROCESS | 4719 | Values: 86.0 85.0 136.0 90.0 86.0 85.0 141.0 84.0 86.0 144.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 14:55:51 INFO - PROCESS | 4719 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 120.0 118.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 14:55:51 INFO - PROCESS | 4719 | Values: 147.0 147.0 147.0 148.0 148.0 151.0 148.0 149.0 148.0 148.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 14:55:51 INFO - PROCESS | 4719 | Values: 96.0 97.0 98.0 96.0 96.0 96.0 96.0 97.0 95.0 95.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.50 stddev:1.32 (2.0%) stddev-sans-first:1.36 14:55:51 INFO - PROCESS | 4719 | Values: 64.0 64.0 66.0 65.0 65.0 64.0 64.0 68.0 64.0 64.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:0.50 14:55:51 INFO - PROCESS | 4719 | Values: 71.0 67.0 67.0 67.0 67.0 66.0 66.0 67.0 67.0 66.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:4.15 (4.8%) stddev-sans-first:4.00 14:55:51 INFO - PROCESS | 4719 | Values: 91.0 88.0 81.0 91.0 86.0 81.0 86.0 91.0 85.0 81.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:139.50 stddev:6.94 (5.0%) stddev-sans-first:7.31 14:55:51 INFO - PROCESS | 4719 | Values: 142.0 133.0 135.0 136.0 134.0 135.0 150.0 137.0 152.0 145.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:1.43 (0.8%) stddev-sans-first:1.50 14:55:51 INFO - PROCESS | 4719 | Values: 169.0 170.0 169.0 168.0 171.0 170.0 167.0 172.0 170.0 170.0 14:55:51 INFO - PROCESS | 4719 | 14:55:51 INFO - PROCESS | 4719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.90 (2.7%) stddev-sans-first:2.00 14:55:51 INFO - PROCESS | 4719 | Values: 71.0 70.0 72.0 74.0 70.0 72.0 70.0 68.0 69.0 68.0 14:55:51 INFO - PROCESS | 4719 | -------- Summary: end -------- 14:55:51 INFO - PROCESS | 4719 | 14:55:52 INFO - TEST-INFO | 4719: exit 0 14:55:52 INFO - TEST-OK | kraken | took 64329ms 14:55:52 INFO - SUITE-END | took 1181s 14:55:53 INFO - Completed test suite (00:19:41) 14:55:53 INFO - javascript benchmark 14:55:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6475.136637819698, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.5605125154348, 2672.5991101334785, 2693.434378780456, 2695.0432596428273, 2717.592361145828, 4687.976560117195, 4816.229403295473, 4835.709857408558, 4852.975735121324, 4873.585745211662, 4734.313524538939, 4777.0, 4811.470738218802, 4831.806727730886, 4832.178529649959, 4417.11657668466, 4434.201843668138, 4508.39136716544, 4516.16450956574, 4577.954220457803, 4475.597196252336, 4500.729956202622, 4552.704074235181, 4557.817687292504, 4586.495485496593, 4455.2871540553515, 4621.4685311189305, 4625.560571745696, 4626.606738427221, 4643.024964757405, 4248.936265956013, 4458.77706114693, 4558.8860278492975, 4587.61005314547, 4601.815927362902, 4335.6965012449145, 4382.956170438287, 4387.100644367897, 4471.977640111779, 4551.431071116111, 4830.758462076918, 4838.274258861164, 4840.249761286971, 4845.3216549683075, 4870.439899411577, 5172.948270517284, 5201.5838732901275, 5203.583713302926, 5224.4775522447835, 5241.109011468059, 5308.177232528964, 5323.494268044529, 5330.7334633268565, 5338.9466105339225, 5371.355437347504, 4967.180415231446, 4967.602591792612, 4970.925436118461, 4975.278584605212, 5003.024410240041, 5095.363079615048, 5322.840314790563, 5364.22218778275, 5386.13821788512, 5430.755615997289, 5189.506996835295, 5200.97399513, 5208.0, 5209.6353255272525, 5243.239730239094, 5286.07493688603, 5296.09966305729, 5296.3909150447425, 5304.257403963448, 5351.25082488452, 4972.279019542146, 5136.383633963948, 5168.715720635326, 5203.479652034766, 5236.319278493771, 4994.425641051253, 5110.693358398508, 5143.7685304161405, 5167.3799144102195, 5179.249008893765, 4385.101054283864, 4393.7363758174615, 4394.099209662011, 4413.426254586947, 4450.3991961085485, 3734.7198960078103, 3807.352750032446, 3854.5374555053013, 3866.5940076292145, 3885.436611691289, 4542.318652202196, 4603.125406172817, 4603.401557797465, 4629.86110416688, 4644.883877903079, 5301.787928482895, 5317.229001794718, 5326.893462130735, 5327.280817089721, 5334.413214546396, 4321.632661223768, 4517.6160026397465, 4576.542345765463, 4598.885027874263, 4639.512851150648, 4672.906541869143, 4691.3432119503295, 4749.881252968635, 4755.262934245197, 4755.928661070017, 4977.800887964513, 4995.25071239317, 4999.550040496373, 5024.42219144803, 5034.917492739079, 5000.849974500771, 5198.714070726146, 5279.340082489689, 5283.2075188722, 5337.066013447554, 4925.285833554186, 4956.801727930842, 4974.054929563371, 4978.950210497994, 4992.675476094042, 5177.145770947752, 5188.948110518846, 5210.452902445189, 5220.608454365862, 5259.053370393366, 4996.225585034325, 5080.517350851663, 5261.605379596469, 5273.393559740679, 5280.683159010318, 4992.8751781205765, 5012.749362531786, 5038.294638750651, 5110.565601923878, 5121.436641969455, 5144.125498665161, 5151.613628977767, 5154.226865970135, 5163.715995620277, 5165.121929271958, 4815.374001379798, 5004.674696144739, 5046.041252162077, 5053.469385714447, 5116.590672746246, 5079.441261461162, 5115.56517696, 5124.410692770379, 5161.509656582619, 5213.713245771367, 5010.799568017384, 5025.120603894231, 5026.3214466048075, 5045.091883460866, 5052.69683818972], "value": 4805.1220527287605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.5600191845564, 549.3298176225004, 550.6723499517791, 560.6019725994545, 561.8286422641096, 28572.428551428984, 37633.81183094084, 39379.21241575167, 39561.802190989074, 43451.78274108625, 41061.58938410615, 41416.0, 41575.79212103943, 41596.79201603995, 41774.0, 7492.550446973185, 7664.770056898302, 7692.730754423596, 7703.037120359955, 7721.112072111695, 7554.320111189992, 7659.004329437165, 7681.0, 7692.7692169235015, 7715.72994945177, 7686.615669216545, 7690.961545192266, 7699.615019249043, 7714.8457030859345, 7747.883781743279, 7667.923320766777, 7699.076110866704, 7700.268474494914, 7727.72952946647, 7754.224577542257, 7538.886916696254, 7579.545227286325, 7617.542947423172, 7630.122535908386, 7636.923630763677, 37246.06884827874, 37425.25149497022, 37486.81256593727, 37598.0, 37645.62354376449, 3072.2626569623353, 3235.8058516489086, 3395.303962687643, 3644.4351125575577, 3821.197548514815, 27733.722662773314, 28211.85894070537, 29449.85275073611, 29689.0, 30552.388952221052, 3457.7060949819297, 3509.0700964244243, 3541.929161416783, 3545.982270088659, 3578.2306804037, 258021.0, 261745.0, 262972.0, 263171.0, 265415.0, 32100.83949580237, 51789.7410512945, 52444.737776310874, 52537.0, 52584.21123683148, 32253.51619725706, 33990.32019359599, 34004.1498962523, 34133.146671333416, 34211.14472138217, 13574.389152487964, 13736.93131534336, 13754.862451375559, 13801.240931748851, 13808.516701915585, 10839.783204335869, 10846.783064338826, 10874.945625271981, 10885.401302928414, 10903.29128606638, 7916.485428447248, 7955.24425179607, 7982.920170798217, 7997.480163789335, 8100.675972961133, 3162.0, 3189.792663476913, 3189.8086114833186, 3253.7071663550396, 3295.143262751702, 865.3639574912435, 891.0106592382592, 906.428949761646, 997.9770734996687, 1023.6059117239917, 26851.194464166107, 27121.9783604406, 27711.584326235123, 27955.30111747182, 28331.858340708164, 863.9092895245909, 953.0802775321848, 957.7988622389377, 966.8308046091905, 994.1202036198017, 14358.138511689333, 14398.85601143996, 14474.986750927334, 14756.631084222765, 14971.40114395412, 385525.0, 391129.0, 393349.0, 396068.0, 397440.0, 49899.0, 49994.0, 50017.0, 50036.74981625069, 50073.24890126651, 1178.7642471505733, 1200.2678366196612, 1215.5745489078752, 1216.8722284160212, 1231.347385885482, 25350.619740704275, 25908.22275331743, 27691.0, 28091.578626320214, 28132.156035318974, 42194.0, 42712.35931460968, 43026.569734302255, 43079.56920430881, 43122.568774311854, 356958.0, 359407.0, 361276.0, 361401.0, 361541.0, 25570.0, 25771.306839342255, 25894.611580825927, 25932.740672593034, 26010.86994565015, 41598.168036639705, 41766.0, 42186.78906605447, 42240.15519689651, 42320.36519452149, 35229.64770352366, 35654.0, 36065.09837253985, 36324.27351453009, 36820.263594728494, 35392.64607353997, 35583.82208088943, 35873.103172420895, 36098.63901360953, 36668.083297917765, 35216.471752923215, 35341.82329088338, 35444.0, 35731.0, 36738.8163059183, 31061.53407698841, 32448.188795280308, 32798.18004549905, 32883.177920552174, 33033.50449743304, 24981.0, 25120.62319065179, 25342.366440839127, 25419.491610168065, 25445.745542544337], "value": 16533.604010033137, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.16268305334995, 356.90006798096533, 359.9316129935312, 369.8150924537731, 377.89796754876187, 15676.529704108882, 16010.119443430607, 16668.333266669335, 17202.053887036207, 17317.39389121378, 13554.39005244764, 17297.740533892003, 17298.56753581161, 17310.56723581911, 17412.912935435335, 4858.927116093261, 5077.59379249661, 5091.745412729368, 5096.949030509684, 5103.5917126629965, 5019.447860735316, 5098.9745051274695, 5102.1836506159025, 5123.641345105844, 5125.077486052509, 6208.286047104596, 6557.967210163943, 6588.571742836701, 6605.174353205849, 6699.229588597325, 6558.409743123118, 6724.823155947714, 6757.628330441824, 6761.9323806761795, 6762.0, 6492.318306577836, 6614.735410583571, 6707.899381509281, 6716.026176204472, 6776.627285499296, 23526.0, 23607.527849442915, 23663.526729465488, 24210.63684044741, 24380.0, 1952.453313072342, 2117.6400011998, 2160.7515135759277, 2206.3711842125076, 2594.4292255703713, 14486.782698259534, 14553.563393098118, 14670.0, 14699.779503307458, 15160.469383571632, 1863.5900101977543, 1893.9242430302772, 1894.9242030318771, 1947.094601010537, 1977.0114942528735, 79936.60031699804, 80728.19271807325, 80984.59507702483, 81421.0, 81680.0, 15740.527784166494, 16139.435119770751, 16729.83270167307, 16735.414260500824, 16957.98252104853, 28239.858800705864, 28285.858570707016, 28307.0, 28322.43355132927, 28613.71386286152, 8721.0, 8839.204471597586, 8945.15021072997, 9122.498262595622, 9253.306002049872, 7268.709251629875, 7340.0457940467395, 7356.926430735624, 7541.47209695327, 7544.3210111089165, 8126.349892008625, 8431.494110353398, 8475.74572762818, 8550.0, 8738.257248133852, 3215.1962009497624, 3401.3707464119216, 3451.361498122855, 3509.4034014217646, 3516.1385460561814, 784.5920121536769, 799.3365506629484, 887.8845750052452, 906.410832958569, 939.5396255834592, 15834.683306333809, 16225.51323460298, 17617.647647046986, 17649.1323883522, 17788.57691384686, 826.8925039744795, 836.1387770596295, 884.5930871799045, 888.1651247827022, 904.0552622509493, 7212.531185473033, 9751.3661611995, 9826.901730982741, 9903.306768526134, 9928.801423971625, 286186.0, 290068.0, 389005.0, 391943.52367096045, 393634.0, 77467.61266193633, 79292.0, 80303.0, 80532.0, 83587.16412835916, 914.8444764390202, 925.2921515040999, 928.7074571509953, 928.9303302252358, 932.7854593443546, 14507.1295722257, 15050.623734406727, 16574.419895303607, 16870.831291686925, 17032.48902532926, 29592.96424625128, 30202.0, 35608.0, 38725.80637096796, 39511.0, 49212.2618160735, 51187.0, 53681.0, 53739.73130134324, 53939.190912137135, 6367.26776420699, 6764.729410823512, 6868.244493105654, 6952.513324067267, 7207.315305046012, 8245.546494942595, 11297.71755706114, 11577.552805899262, 11745.706357341134, 12721.681957951125, 10540.420276884844, 10759.623413180501, 10994.065504432212, 11048.281861678965, 11146.944265278622, 10823.891761082288, 10905.672829815117, 10973.0, 11023.283486573348, 11120.277181983469, 10941.0, 10982.0, 11028.22802403824, 11217.775644487228, 11277.097832173571, 7166.641667916688, 7433.256674332523, 7513.060867391576, 7711.8843217352905, 8081.757547273592, 10722.410267435365, 10804.513796879002, 10810.027097561257, 10818.809930907752, 10985.670429887115], "value": 9249.629988199684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.5853264754246, 1402.060619385012, 1484.7698606715956, 1651.9008859468424, 1696.5758560359902, 6533.216014078305, 7199.496035277532, 7362.226966168556, 7773.533587984718, 7784.961075194623, 7469.327760501554, 7710.768676939687, 7712.961435192816, 7724.150343462229, 7727.111382191049, 2116.492041909946, 2158.0720290275176, 2165.9783402165936, 2166.057764872278, 2168.934931952044, 2097.842661800371, 2126.9893650531726, 2136.327056977047, 2146.5384942237415, 2152.1391443422676, 2156.3638726575696, 2158.881261530615, 2160.8487405881597, 2163.5456554123575, 2198.7581366049803, 2089.5925294567564, 2096.549241912981, 2096.559722458278, 2096.7798381169987, 2100.9159633614636, 2025.3518873960338, 2106.452322396188, 2122.395117391536, 2137.1237792505, 2140.4113868686236, 7764.495307805031, 7813.218678132198, 7836.138024817265, 7873.842523149505, 7876.684932602689, 4370.2789039808395, 4465.129299786543, 4512.413386259798, 4518.615917647004, 4523.660725445572, 2824.7316504932, 2860.2706309890846, 2895.7683385329124, 2931.4430258250864, 2933.1933718227447, 901.589776651622, 939.3518472254123, 941.3786900645609, 941.9764505887408, 943.5942544705774, 10518.684439466904, 10524.31591946521, 10545.84181237282, 10565.73585660357, 10568.630097946612, 3774.245150969817, 3905.258000979805, 4046.716729828943, 4071.776052317151, 4077.204945035749, 8932.821343573092, 8936.195742383217, 8951.283897288331, 8971.192592666692, 8988.235999940078, 4498.987727761293, 4531.524189960072, 4534.79593418297, 4543.522930092293, 4545.272756359032, 3425.53755243044, 3908.921821563553, 3995.700322475826, 4112.588741125924, 4114.382842573578, 3607.152319204985, 3610.808433217032, 3672.57765356982, 3687.9262414751556, 3855.749376290532, 1172.0974849366112, 1172.695099274195, 1185.4428418643224, 1186.0371085852928, 1186.5253898440692, 752.2327226229215, 758.2493331601675, 805.6374631415887, 805.6938363421863, 829.9087100418949, 4970.378702662168, 4989.451160372356, 4998.925016124761, 5089.491050894881, 5144.0, 360.9747317687789, 363.208206110676, 365.89389077167857, 368.8874893157613, 379.46495441427453, 3479.2519608283833, 3492.5634295713035, 3507.649235076472, 3530.894073177809, 3624.3294990426857, 9078.773030674285, 9420.62317507292, 9533.570989305497, 9543.570539325747, 9551.331406801457, 9496.09787070241, 9496.905030949601, 9580.473073980998, 9592.76018099553, 9609.663661771805, 7260.346568808727, 7265.745698900513, 7312.232215617496, 7324.974503569504, 7343.192248852729, 4993.625478089085, 5114.33513643224, 5182.6890386575415, 5319.175527793198, 5361.62468627208, 8586.398952073296, 8591.613377398156, 8804.955975220082, 8875.689350872688, 8891.555422228992, 8413.537255451009, 8571.40000200005, 8603.311735061305, 8836.204741573289, 8847.911520884967, 5649.406812284651, 6554.0, 6570.967145164434, 6663.36698013688, 6786.151731033621, 7487.251274872469, 7561.4706970513735, 7564.092308922965, 7571.697132114654, 7575.545467271982, 6521.217453905561, 6638.90041649366, 6708.6310252936555, 6786.966065169642, 6864.073350097673, 6579.243387010363, 6660.533762636569, 6704.128463299739, 6831.521793474409, 6956.478264130109, 6072.514198863992, 6160.599561028519, 6168.9691551541955, 6171.537134715004, 6172.321044684992, 4477.641788656834, 4542.250528662866, 4550.408446901882, 4613.123506533748, 4699.365585645894, 4453.955460445354, 4557.1797076526545, 4623.329617205553, 4633.235516139799, 4750.12122757291], "value": 3979.8088298656726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.1786907314156, 291.2151751030971, 299.4744223887078, 300.1655397993578, 305.40141323006907, 4900.754962251891, 4989.550940415362, 5037.916847877706, 5124.8975020499565, 5130.486951304868, 4993.675411098285, 5021.221710634848, 5025.7487125643665, 5031.547160755531, 5059.822906198284, 3975.9801200993957, 3996.0, 4000.8599699010542, 4010.278149933011, 4015.7791321477307, 3855.8650447234354, 3997.680185585161, 4012.4382586437923, 4013.779242141681, 4022.8189731462153, 3930.272899513599, 3935.8032098394965, 3956.4263181838614, 3956.9010774730573, 3970.7617542947514, 3951.881443556698, 3955.624215699504, 3958.703097267702, 3962.5046869141356, 3975.662068724162, 3510.0, 3519.2081781598936, 3524.22467057247, 3533.5406397168463, 3548.964510354889, 4862.027594481083, 4896.559309662111, 4927.753612319406, 4969.503049695038, 5000.89998200034, 4515.245700122922, 4534.614557762594, 4547.5452454754595, 4566.292224705143, 4581.289900065495, 5272.604554658416, 5282.815101471469, 5292.550133238679, 5293.100172970604, 5312.814051508218, 3696.537932758405, 3786.7314449659398, 3810.5998870118515, 3825.2158307547165, 3848.2111167210655, 5488.807891723811, 5499.642523235977, 5513.173024046385, 5516.586256030814, 5596.3284405871145, 3910.9022274442796, 3924.156306394139, 3945.3292940200236, 3955.1891862168186, 3959.6436320731273, 3823.3500304948225, 3959.891230455477, 4007.1584967157223, 4007.6192761687594, 4011.618896204856, 4463.464384273908, 4464.888377790581, 4482.596566309048, 4494.662900282492, 4525.456945166601, 5270.209468579667, 5324.0, 5330.200469929541, 5335.413104558495, 5348.91976620351, 1293.9676508087373, 1321.6387121265113, 1340.604521666111, 1353.8375394952668, 1354.1739538881275, 904.3895370624933, 913.5428990759727, 950.2018304624149, 950.2018304624149, 950.6197520991659, 4597.218472859622, 4613.976930115395, 4632.69887457321, 4633.617459254763, 4633.9536604634195, 5382.703951282717, 5398.865028374322, 5400.810971615974, 5404.621676482609, 5405.162199859028, 4443.422355093817, 4603.148417542765, 4608.470025946992, 4616.192166370872, 4649.697769644962, 2490.1284550407577, 2490.638857365672, 2515.132279363617, 2526.5199612074016, 2535.378832186126, 4454.933176002362, 4489.32660100981, 4512.954870451319, 4522.841700540465, 4543.0, 4556.908861822812, 4823.686460380064, 4829.782659780319, 4837.95162048382, 4854.417469903564, 4367.100311364567, 4425.84509542171, 4431.290993441098, 4458.2420988431395, 4467.486239082482, 4730.550597693214, 4737.265723812815, 4758.952410475851, 4784.497627749036, 4788.569028787426, 4619.745913974763, 4643.651726120487, 4648.930266045944, 4656.93014604788, 4664.930026049544, 4734.21885388907, 5058.494150584912, 5089.684193691935, 5101.7194054327365, 5129.384473863011, 3778.3576791944884, 3785.6782173515558, 3795.867144649924, 3810.7332486725663, 3855.51806024247, 5235.554977826928, 5518.586106042143, 5519.806806761744, 5526.143447765603, 5532.695701736443, 5140.46025167367, 5225.085610018155, 5242.659227150223, 5251.973740131275, 5261.973690131525, 5228.37259528859, 5244.688827793052, 5248.265242865926, 5299.311089558333, 5302.496262855023, 5052.72210028452, 5150.248915368793, 5154.716490593053, 5185.948140518546, 5188.195829646411, 5267.157254839208, 5275.551578115903, 5302.284191634234, 5337.452138879837, 5342.1452567589, 5173.163526947879, 5189.299444574934, 5195.610329225247, 5210.7494201392155, 5221.399539053057], "value": 3899.466072161901, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.5305403582404, 671.2213831954933, 715.8174665460307, 722.2452537098732, 750.8723517002111, 13186.472541098357, 14197.361118749655, 14288.428462861486, 14315.141091534515, 15138.772918406205, 14842.406303747865, 14978.850211497882, 15042.323095460702, 15047.77428338573, 15116.0, 758.037292638349, 780.2821404308022, 784.3333166808225, 785.7367781793077, 788.420510924473, 629.5813284166024, 749.2470067582072, 766.6281853301144, 772.0195351903079, 778.7235531386361, 803.236924921327, 804.5936801915025, 810.4448452809814, 811.8863359129726, 813.2639960835423, 796.928276455116, 799.2327365728908, 801.3789313282194, 802.7471346525855, 805.138501803071, 585.4613755345093, 588.3880764005429, 589.1545632018068, 589.7051474262869, 592.7806711516766, 13703.725925481534, 13718.176909385369, 13739.656508587266, 13757.862421375758, 13824.170549767046, 12540.874591254062, 13090.672733181651, 13694.726105477934, 13719.245441500714, 13840.377183026789, 10709.410982395964, 10998.725031874266, 11141.331520108819, 11176.552937882476, 11255.887441125566, 3311.9503207451667, 3360.1263671445354, 3366.074329559366, 3390.9491357629654, 3490.441529355291, 68157.65921170362, 68408.31591684069, 68923.31076689219, 69555.0, 69588.65205673939, 9926.900730992742, 10186.898131018595, 10268.486575671335, 10341.63804266847, 10359.63741269052, 18684.532886677942, 18697.719534206997, 18823.247070117315, 19049.80950190508, 19081.809181908004, 6809.216940051859, 7052.682629281695, 7132.821679458055, 7372.815679607946, 7511.173770885308, 3787.2614840106467, 3825.12022234882, 3864.4976153099915, 3866.130120722815, 3906.8632597859505, 2608.5174242765147, 2670.6661667291587, 2698.5007773561956, 2705.702372738997, 2739.8630068496495, 485.6915858429852, 487.6342742942793, 488.2773495227013, 504.399764280505, 514.3698968763235, 495.6109454078603, 522.7778194267421, 584.1763114009227, 616.1897105306508, 653.323809856796, 8256.504609723435, 8707.129287071242, 8763.25512331459, 8897.421667591585, 8918.73243802687, 498.99002019959397, 516.51963673783, 523.1316015414394, 598.9281286245591, 611.0803241122082, 3953.6639385652543, 4125.546189919107, 4187.539370669285, 4267.551907049778, 4269.87190384289, 79376.60311698404, 95064.14807555784, 96015.51992239994, 97705.0, 97774.51112744391, 46306.0, 46549.0, 47073.29390059152, 47590.28614570784, 81850.18149818426, 70635.0, 70797.0, 71492.64253678698, 73271.99999999894, 74802.25197748061, 7620.466567340454, 7734.701729315437, 7862.60686965638, 7878.566678832719, 7936.2857342839425, 44015.55984440115, 44077.55922440735, 44622.77688611536, 44812.77593612011, 45050.0, 57003.714981424826, 60331.69834150801, 65516.34483655103, 65728.34271657222, 68529.3147068523, 9698.854517182106, 9813.460259685786, 10047.497625118569, 10213.285070045322, 10317.896821031694, 11076.280041797258, 11184.406901080558, 11254.7749045017, 11335.943320283346, 11624.360660163435, 10689.091427228772, 10828.0, 10892.945535272273, 11032.944835275772, 11086.113110951266, 10760.784784304113, 10779.299345542515, 10858.891411085788, 10922.781544369227, 11011.339319640847, 10355.792884142425, 10515.106215971728, 10904.182186335898, 11540.711482213012, 11768.52925882955, 9929.35459195179, 9977.551010204414, 10099.545520451451, 10644.89355106439, 10750.408727520062, 9107.908920910706, 9518.857217141609, 9713.980032096528, 9817.950910245403, 9818.65634702782], "value": 6462.21031925129, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 113.0, 116.0, 116.0, 116.0, 115.0, 115.0, 115.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 144.0, 182.0, 124.0, 162.0, 150.0, 125.0, 183.0, 130.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 171.0, 162.0, 163.0, 166.0, 164.0, 163.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 173.0, 77.0, 75.0, 76.0, 77.0, 164.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 136.0, 90.0, 86.0, 85.0, 141.0, 84.0, 86.0, 144.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 120.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 151.0, 148.0, 149.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 65.0, 65.0, 64.0, 64.0, 68.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 81.0, 91.0, 86.0, 81.0, 86.0, 91.0, 85.0, 81.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 135.0, 136.0, 134.0, 135.0, 150.0, 137.0, 152.0, 145.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 169.0, 168.0, 171.0, 170.0, 167.0, 172.0, 170.0, 170.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 74.0, 70.0, 72.0, 70.0, 68.0, 69.0, 68.0], "value": 70.4, "unit": "score"}]}]} 14:55:53 INFO - Return code: 0 14:55:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:55:53 ERROR - # TBPL SUCCESS # 14:55:53 INFO - Running post-action listener: _resource_record_post_action 14:55:53 INFO - [mozharness: 2016-08-11 21:55:53.185628Z] Finished run-tests step (success) 14:55:53 INFO - Running post-run listener: _resource_record_post_run 14:55:53 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 290504704; Read time: 368; Write time: 243632 14:55:53 INFO - TinderboxPrint: CPU usage
13.4% 14:55:53 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 368 14:55:53 INFO - TinderboxPrint: I/O write bytes / time
290,504,704 / 243,632 14:55:53 INFO - TinderboxPrint: CPU idle
8,281.8 (86.6%) 14:55:53 INFO - TinderboxPrint: CPU user
1,221.7 (12.8%) 14:55:53 INFO - TinderboxPrint: Swap in / out
0 / 0 14:55:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1216512; Read time: 0; Write time: 56 14:55:53 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289288192; Read time: 356; Write time: 243576 14:55:53 INFO - Running post-run listener: _upload_blobber_files 14:55:53 INFO - Blob upload gear active. 14:55:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:55:53 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 14:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:55:54 INFO - (blobuploader) - INFO - Open directory for files ... 14:55:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:55:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:55:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:54 INFO - (blobuploader) - INFO - Done attempting. 14:55:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:55:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:55:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:55 INFO - (blobuploader) - INFO - Done attempting. 14:55:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:55:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:58 INFO - (blobuploader) - INFO - Done attempting. 14:55:58 INFO - (blobuploader) - INFO - Iteration through files over. 14:55:58 INFO - Return code: 0 14:55:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:55:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:55:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe6ee5aac2b9dc0662ed6310043c685e5420fb2ce9b2ab31df09130d161449630499789d12f550044c320a3d28ff52e3381b6b0d2679020a68171f5b1d91bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132b250e3f7144dfaccceafb45dbfdbdd99fd82860063898b3a63b659593d051bc2c2effa5fd33ef2a14152ce5d548c06c2b5a2f369184add235f2caf415cbc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c72ba8776167cd58fb592b990d98ff7e431d872e7595ebc41494eb4563398ff7b7703f0c96a0b448791ba66b5e65c43bcc84d51ca62937f3350eea9a26fe383e"} 14:55:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:55:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:55:58 INFO - Contents: 14:55:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe6ee5aac2b9dc0662ed6310043c685e5420fb2ce9b2ab31df09130d161449630499789d12f550044c320a3d28ff52e3381b6b0d2679020a68171f5b1d91bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132b250e3f7144dfaccceafb45dbfdbdd99fd82860063898b3a63b659593d051bc2c2effa5fd33ef2a14152ce5d548c06c2b5a2f369184add235f2caf415cbc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c72ba8776167cd58fb592b990d98ff7e431d872e7595ebc41494eb4563398ff7b7703f0c96a0b448791ba66b5e65c43bcc84d51ca62937f3350eea9a26fe383e"} 14:55:58 INFO - Running post-run listener: copy_logs_to_upload_dir 14:55:58 INFO - Copying logs to upload dir... 14:55:58 INFO - mkdir: /builds/slave/test/build/upload/logs 14:55:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.431327 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-11 14:55:58.870755) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 14:55:58.874871) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe6ee5aac2b9dc0662ed6310043c685e5420fb2ce9b2ab31df09130d161449630499789d12f550044c320a3d28ff52e3381b6b0d2679020a68171f5b1d91bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132b250e3f7144dfaccceafb45dbfdbdd99fd82860063898b3a63b659593d051bc2c2effa5fd33ef2a14152ce5d548c06c2b5a2f369184add235f2caf415cbc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c72ba8776167cd58fb592b990d98ff7e431d872e7595ebc41494eb4563398ff7b7703f0c96a0b448791ba66b5e65c43bcc84d51ca62937f3350eea9a26fe383e"} build_url:https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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-Non-PGO/sha512/fe6ee5aac2b9dc0662ed6310043c685e5420fb2ce9b2ab31df09130d161449630499789d12f550044c320a3d28ff52e3381b6b0d2679020a68171f5b1d91bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/132b250e3f7144dfaccceafb45dbfdbdd99fd82860063898b3a63b659593d051bc2c2effa5fd33ef2a14152ce5d548c06c2b5a2f369184add235f2caf415cbc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c72ba8776167cd58fb592b990d98ff7e431d872e7595ebc41494eb4563398ff7b7703f0c96a0b448791ba66b5e65c43bcc84d51ca62937f3350eea9a26fe383e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 14:55:58.900698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:55:58.901063) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470951319.791036-55267406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:55:58.986674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 14:55:58.987045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 14:55:58.987395) ========= ========= Total master_lag: 0.18 =========