builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1469367711.94 results: success (0) buildid: 20160724060326 builduid: a43e9358917d44dba3b6ef08b41e6865 revision: d12890b78b043ccc2445dcef144e982f83b65e5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:51.936952) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:51.937439) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:51.937758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:52.400930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:52.401226) ========= 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=232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-24 06:41:52-- 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% 71.1M=0s 2016-07-24 06:41:53 (71.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:52.521187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:52.521552) ========= 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=232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014826 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:52.571973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:52.572398) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d12890b78b043ccc2445dcef144e982f83b65e5f --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 d12890b78b043ccc2445dcef144e982f83b65e5f --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=232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-24 06:41:53,167 truncating revision to first 12 chars 2016-07-24 06:41:53,167 Setting DEBUG logging. 2016-07-24 06:41:53,167 attempt 1/10 2016-07-24 06:41:53,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d12890b78b04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-24 06:41:53,598 unpacking tar archive at: fx-team-d12890b78b04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:53.385481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:53.385822) ========= script_repo_revision: d12890b78b043ccc2445dcef144e982f83b65e5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:53.386285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:53.386633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 06:41:53.400311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-24 06:41:53.400870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:41:54 INFO - MultiFileLogger online at 20160724 06:41:54 in /builds/slave/test 06:41:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:41:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:41:54 INFO - {'append_to_log': False, 06:41:54 INFO - 'base_work_dir': '/builds/slave/test', 06:41:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:41:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:41:54 INFO - 'branch': 'Fx-Team-Non-PGO', 06:41:54 INFO - 'buildbot_json_path': 'buildprops.json', 06:41:54 INFO - 'config_files': ('talos/linux_config.py',), 06:41:54 INFO - 'default_actions': ('clobber', 06:41:54 INFO - 'read-buildbot-config', 06:41:54 INFO - 'download-and-extract', 06:41:54 INFO - 'populate-webroot', 06:41:54 INFO - 'create-virtualenv', 06:41:54 INFO - 'install', 06:41:54 INFO - 'run-tests'), 06:41:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:41:54 INFO - 'download_minidump_stackwalk': True, 06:41:54 INFO - 'download_symbols': 'ondemand', 06:41:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:41:54 INFO - 'tooltool.py': '/tools/tooltool.py', 06:41:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:41:54 INFO - '/tools/misc-python/virtualenv.py')}, 06:41:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:41:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:41:54 INFO - 'installer_path': 'installer.exe', 06:41:54 INFO - 'log_level': 'info', 06:41:54 INFO - 'log_name': 'talos', 06:41:54 INFO - 'log_to_console': True, 06:41:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:41:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:41:54 INFO - 'opt_config_files': (), 06:41:54 INFO - 'pip_index': False, 06:41:54 INFO - 'sps_profile': False, 06:41:54 INFO - 'sps_profile_interval': 0, 06:41:54 INFO - 'suite': 'dromaeojs', 06:41:54 INFO - 'system_bits': '32', 06:41:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:41:54 INFO - 'title': 'talos-linux64-ix-025', 06:41:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:41:54 INFO - 'use_talos_json': True, 06:41:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:41:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:41:54 INFO - 'work_dir': 'build'} 06:41:54 INFO - [mozharness: 2016-07-24 13:41:54.085679Z] Running clobber step. 06:41:54 INFO - Running pre-action listener: _resource_record_pre_action 06:41:54 INFO - Running main action method: clobber 06:41:54 INFO - rmtree: /builds/slave/test/build 06:41:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:55 INFO - Running post-action listener: _resource_record_post_action 06:41:55 INFO - [mozharness: 2016-07-24 13:41:55.064087Z] Finished clobber step (success) 06:41:55 INFO - [mozharness: 2016-07-24 13:41:55.064186Z] Running read-buildbot-config step. 06:41:55 INFO - Running pre-action listener: _resource_record_pre_action 06:41:55 INFO - Running main action method: read_buildbot_config 06:41:55 INFO - Using buildbot properties: 06:41:55 INFO - { 06:41:55 INFO - "project": "", 06:41:55 INFO - "product": "firefox", 06:41:55 INFO - "script_repo_revision": "production", 06:41:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:41:55 INFO - "repository": "", 06:41:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:41:55 INFO - "buildid": "20160724060326", 06:41:55 INFO - "pgo_build": "False", 06:41:55 INFO - "basedir": "/builds/slave/test", 06:41:55 INFO - "buildnumber": 3194, 06:41:55 INFO - "slavename": "talos-linux64-ix-025", 06:41:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:41:55 INFO - "platform": "ubuntu64_hw", 06:41:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:41:55 INFO - "branch": "fx-team", 06:41:55 INFO - "repo_path": "integration/fx-team", 06:41:55 INFO - "revision": "d12890b78b043ccc2445dcef144e982f83b65e5f", 06:41:55 INFO - "stage_platform": "linux64", 06:41:55 INFO - "builduid": "a43e9358917d44dba3b6ef08b41e6865", 06:41:55 INFO - "slavebuilddir": "test" 06:41:55 INFO - } 06:41:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:41:55 INFO - Running post-action listener: _resource_record_post_action 06:41:55 INFO - [mozharness: 2016-07-24 13:41:55.066633Z] Finished read-buildbot-config step (success) 06:41:55 INFO - [mozharness: 2016-07-24 13:41:55.066722Z] Running download-and-extract step. 06:41:55 INFO - Running pre-action listener: _resource_record_pre_action 06:41:55 INFO - Running main action method: download_and_extract 06:41:55 INFO - mkdir: /builds/slave/test/build/tests 06:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:55 INFO - https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:41:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:41:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:41:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:42:07 INFO - Downloaded 1361 bytes. 06:42:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:42:07 INFO - Using the following test package requirements: 06:42:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:42:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:42:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:42:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'jsshell-linux-x86_64.zip'], 06:42:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:42:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:42:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:42:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:42:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:42:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:42:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:42:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:07 INFO - https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:42:17 INFO - Downloaded 22737593 bytes. 06:42:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:42:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:42:18 INFO - Return code: 0 06:42:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:18 INFO - https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:42:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:42:20 INFO - Downloaded 22737593 bytes. 06:42:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:42:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:42:21 INFO - Return code: 0 06:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:21 INFO - https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:42:22 INFO - Downloaded 14403289 bytes. 06:42:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:42:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:42:23 INFO - Return code: 0 06:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:23 INFO - https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:42:24 INFO - Downloaded 57159848 bytes. 06:42:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:24 INFO - mkdir: /builds/slave/test/properties 06:42:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:24 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:24 INFO - Contents: 06:42:24 INFO - build_url:https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:42:25 INFO - Running post-action listener: _resource_record_post_action 06:42:25 INFO - Running post-action listener: set_extra_try_arguments 06:42:25 INFO - [mozharness: 2016-07-24 13:42:25.236547Z] Finished download-and-extract step (success) 06:42:25 INFO - [mozharness: 2016-07-24 13:42:25.236779Z] Running populate-webroot step. 06:42:25 INFO - Running pre-action listener: _resource_record_pre_action 06:42:25 INFO - Running main action method: populate_webroot 06:42:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:42:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:42:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:42:25 INFO - '--tppagecycles', 06:42:25 INFO - '7'], 06:42:25 INFO - 'tests': ['tsvgm']}}, 06:42:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:42:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:42:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['damp', 'tps']}, 06:42:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'tests': ['damp', 'tps']}, 06:42:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['dromaeo_dom']}, 06:42:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['basic_compositor_video']}, 06:42:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:42:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['a11yr', 06:42:25 INFO - 'ts_paint', 06:42:25 INFO - 'tpaint', 06:42:25 INFO - 'sessionrestore', 06:42:25 INFO - 'sessionrestore_no_auto_restore', 06:42:25 INFO - 'tabpaint']}, 06:42:25 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:25 INFO - 'ts_paint', 06:42:25 INFO - 'tpaint', 06:42:25 INFO - 'sessionrestore', 06:42:25 INFO - 'sessionrestore_no_auto_restore', 06:42:25 INFO - 'tabpaint']}, 06:42:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:42:25 INFO - 'ts_paint', 06:42:25 INFO - 'tpaint', 06:42:25 INFO - 'sessionrestore', 06:42:25 INFO - 'sessionrestore_no_auto_restore', 06:42:25 INFO - 'tabpaint']}, 06:42:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:42:25 INFO - 'ts_paint', 06:42:25 INFO - 'tpaint', 06:42:25 INFO - 'sessionrestore', 06:42:25 INFO - 'sessionrestore_no_auto_restore', 06:42:25 INFO - 'tabpaint']}, 06:42:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['a11yr', 06:42:25 INFO - 'ts_paint', 06:42:25 INFO - 'tpaint', 06:42:25 INFO - 'sessionrestore', 06:42:25 INFO - 'sessionrestore_no_auto_restore', 06:42:25 INFO - 'tabpaint']}, 06:42:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['a11yr', 06:42:25 INFO - 'ts_paint', 06:42:25 INFO - 'tpaint', 06:42:25 INFO - 'sessionrestore', 06:42:25 INFO - 'sessionrestore_no_auto_restore', 06:42:25 INFO - 'tabpaint']}, 06:42:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['tsvgx', 06:42:25 INFO - 'tsvgr_opacity', 06:42:25 INFO - 'tart', 06:42:25 INFO - 'tscrollx', 06:42:25 INFO - 'cart']}, 06:42:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:25 INFO - 'tsvgr_opacity', 06:42:25 INFO - 'tart', 06:42:25 INFO - 'tscrollx', 06:42:25 INFO - 'cart']}, 06:42:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'talos_options': ['--disable-e10s'], 06:42:25 INFO - 'tests': ['tp5o']}, 06:42:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'tests': ['tp5o']}, 06:42:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'talos_options': ['--disable-e10s', 06:42:25 INFO - '--xperf_path', 06:42:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:25 INFO - 'tests': ['tp5n']}, 06:42:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:25 INFO - 'talos_options': ['--xperf_path', 06:42:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:25 INFO - 'tests': ['tp5n']}}, 06:42:25 INFO - 'talos.zip': {'path': '', 06:42:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:42:25 INFO - Running post-action listener: _resource_record_post_action 06:42:25 INFO - [mozharness: 2016-07-24 13:42:25.255428Z] Finished populate-webroot step (success) 06:42:25 INFO - [mozharness: 2016-07-24 13:42:25.255517Z] Running create-virtualenv step. 06:42:25 INFO - Running pre-action listener: _resource_record_pre_action 06:42:25 INFO - Running main action method: create_virtualenv 06:42:25 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:25 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 06:42:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:25 INFO - Using real prefix '/usr' 06:42:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:25 INFO - Installing distribute.............................................................................................................................................................................................done. 06:42:27 INFO - Installing pip.................done. 06:42:27 INFO - Return code: 0 06:42:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:42: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:27 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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:27 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 06:42:27 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 06:42:27 INFO - Using env: {'DISPLAY': ':0', 06:42:27 INFO - 'HOME': '/home/cltbld', 06:42:27 INFO - 'LANG': 'en_US.UTF-8', 06:42:27 INFO - 'LANGUAGE': 'en_US:en', 06:42:27 INFO - 'LOGNAME': 'cltbld', 06:42:27 INFO - 'MAIL': '/var/mail/cltbld', 06:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:27 INFO - 'MOZ_NO_REMOTE': '1', 06:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:27 INFO - 'NO_EM_RESTART': '1', 06:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:27 INFO - 'PWD': '/builds/slave/test', 06:42:27 INFO - 'SHELL': '/bin/bash', 06:42:27 INFO - 'SHLVL': '1', 06:42:27 INFO - 'TERM': 'linux', 06:42:27 INFO - 'TMOUT': '86400', 06:42:27 INFO - 'USER': 'cltbld', 06:42:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:27 INFO - '_': '/tools/buildbot/bin/python'} 06:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:28 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 06:42:28 INFO - Cleaning up... 06:42:28 INFO - Return code: 0 06:42:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:28 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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:28 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 06:42:28 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 06:42:28 INFO - Using env: {'DISPLAY': ':0', 06:42:28 INFO - 'HOME': '/home/cltbld', 06:42:28 INFO - 'LANG': 'en_US.UTF-8', 06:42:28 INFO - 'LANGUAGE': 'en_US:en', 06:42:28 INFO - 'LOGNAME': 'cltbld', 06:42:28 INFO - 'MAIL': '/var/mail/cltbld', 06:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:28 INFO - 'MOZ_NO_REMOTE': '1', 06:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:28 INFO - 'NO_EM_RESTART': '1', 06:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:28 INFO - 'PWD': '/builds/slave/test', 06:42:28 INFO - 'SHELL': '/bin/bash', 06:42:28 INFO - 'SHLVL': '1', 06:42:28 INFO - 'TERM': 'linux', 06:42:28 INFO - 'TMOUT': '86400', 06:42:28 INFO - 'USER': 'cltbld', 06:42:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:28 INFO - '_': '/tools/buildbot/bin/python'} 06:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:28 INFO - Downloading/unpacking psutil>=3.1.1 06:42:28 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 06:42:28 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 06:42:28 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 06:42:28 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 06:42:28 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 06:42:28 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 06:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:42:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:30 INFO - Installing collected packages: psutil 06:42:30 INFO - Running setup.py install for psutil 06:42:30 INFO - building 'psutil._psutil_linux' extension 06:42:30 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 06:42:30 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 06:42:30 INFO - building 'psutil._psutil_posix' extension 06:42:30 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 06:42:30 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 06:42:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:30 INFO - Successfully installed psutil 06:42:30 INFO - Cleaning up... 06:42:30 INFO - Return code: 0 06:42:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:30 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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:30 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 06:42:30 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 06:42:30 INFO - Using env: {'DISPLAY': ':0', 06:42:30 INFO - 'HOME': '/home/cltbld', 06:42:30 INFO - 'LANG': 'en_US.UTF-8', 06:42:30 INFO - 'LANGUAGE': 'en_US:en', 06:42:30 INFO - 'LOGNAME': 'cltbld', 06:42:30 INFO - 'MAIL': '/var/mail/cltbld', 06:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:30 INFO - 'MOZ_NO_REMOTE': '1', 06:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:30 INFO - 'NO_EM_RESTART': '1', 06:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:30 INFO - 'PWD': '/builds/slave/test', 06:42:30 INFO - 'SHELL': '/bin/bash', 06:42:30 INFO - 'SHLVL': '1', 06:42:30 INFO - 'TERM': 'linux', 06:42:30 INFO - 'TMOUT': '86400', 06:42:30 INFO - 'USER': 'cltbld', 06:42:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:30 INFO - '_': '/tools/buildbot/bin/python'} 06:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:42:31 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 06:42:31 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 06:42:31 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 06:42:31 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 06:42:31 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 06:42:31 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 06:42:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:42:32 INFO - Installing collected packages: mozsystemmonitor 06:42:32 INFO - Running setup.py install for mozsystemmonitor 06:42:32 INFO - Successfully installed mozsystemmonitor 06:42:32 INFO - Cleaning up... 06:42:32 INFO - Return code: 0 06:42:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42: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', '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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:42: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 jsonschema==2.5.1 06:42:32 INFO - Using env: {'DISPLAY': ':0', 06:42:32 INFO - 'HOME': '/home/cltbld', 06:42:32 INFO - 'LANG': 'en_US.UTF-8', 06:42:32 INFO - 'LANGUAGE': 'en_US:en', 06:42:32 INFO - 'LOGNAME': 'cltbld', 06:42:32 INFO - 'MAIL': '/var/mail/cltbld', 06:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:32 INFO - 'MOZ_NO_REMOTE': '1', 06:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:32 INFO - 'NO_EM_RESTART': '1', 06:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:32 INFO - 'PWD': '/builds/slave/test', 06:42:32 INFO - 'SHELL': '/bin/bash', 06:42:32 INFO - 'SHLVL': '1', 06:42:32 INFO - 'TERM': 'linux', 06:42:32 INFO - 'TMOUT': '86400', 06:42:32 INFO - 'USER': 'cltbld', 06:42:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:32 INFO - '_': '/tools/buildbot/bin/python'} 06:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:32 INFO - Downloading/unpacking jsonschema==2.5.1 06:42:32 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 06:42:32 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 06:42:32 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 06:42:32 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 06:42:32 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 06:42:32 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 06:42:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:42:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:42:34 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 06:42:34 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 06:42:34 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 06:42:34 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 06:42:34 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 06:42:34 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 06:42:35 INFO - Downloading functools32-3.2.3-2.tar.gz 06:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:42:35 INFO - warning: no files found matching '*.txt' 06:42:35 INFO - no previously-included directories found matching 'build' 06:42:35 INFO - no previously-included directories found matching 'dist' 06:42:35 INFO - no previously-included directories found matching '.git*' 06:42:35 INFO - Installing collected packages: jsonschema, functools32 06:42:35 INFO - Running setup.py install for functools32 06:42:35 INFO - warning: no files found matching '*.txt' 06:42:35 INFO - no previously-included directories found matching 'build' 06:42:35 INFO - no previously-included directories found matching 'dist' 06:42:35 INFO - no previously-included directories found matching '.git*' 06:42:35 INFO - Successfully installed jsonschema functools32 06:42:35 INFO - Cleaning up... 06:42:35 INFO - Return code: 0 06:42:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:35 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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:35 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 06:42:35 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 06:42:35 INFO - Using env: {'DISPLAY': ':0', 06:42:35 INFO - 'HOME': '/home/cltbld', 06:42:35 INFO - 'LANG': 'en_US.UTF-8', 06:42:35 INFO - 'LANGUAGE': 'en_US:en', 06:42:35 INFO - 'LOGNAME': 'cltbld', 06:42:35 INFO - 'MAIL': '/var/mail/cltbld', 06:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:35 INFO - 'MOZ_NO_REMOTE': '1', 06:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:35 INFO - 'NO_EM_RESTART': '1', 06:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:35 INFO - 'PWD': '/builds/slave/test', 06:42:35 INFO - 'SHELL': '/bin/bash', 06:42:35 INFO - 'SHLVL': '1', 06:42:35 INFO - 'TERM': 'linux', 06:42:35 INFO - 'TMOUT': '86400', 06:42:35 INFO - 'USER': 'cltbld', 06:42:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:35 INFO - '_': '/tools/buildbot/bin/python'} 06:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:42:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:42:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:38 INFO - Downloading docopt-0.6.1.tar.gz 06:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:42:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:42:38 INFO - Running setup.py install for blobuploader 06:42:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:42:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:42:38 INFO - Running setup.py install for requests 06:42:38 INFO - Running setup.py install for docopt 06:42:38 INFO - Successfully installed blobuploader requests docopt 06:42:38 INFO - Cleaning up... 06:42:38 INFO - Return code: 0 06:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:38 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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:38 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 06:42:38 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 06:42:38 INFO - Using env: {'DISPLAY': ':0', 06:42:38 INFO - 'HOME': '/home/cltbld', 06:42:38 INFO - 'LANG': 'en_US.UTF-8', 06:42:38 INFO - 'LANGUAGE': 'en_US:en', 06:42:38 INFO - 'LOGNAME': 'cltbld', 06:42:38 INFO - 'MAIL': '/var/mail/cltbld', 06:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:38 INFO - 'MOZ_NO_REMOTE': '1', 06:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:38 INFO - 'NO_EM_RESTART': '1', 06:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:38 INFO - 'PWD': '/builds/slave/test', 06:42:38 INFO - 'SHELL': '/bin/bash', 06:42:38 INFO - 'SHLVL': '1', 06:42:38 INFO - 'TERM': 'linux', 06:42:38 INFO - 'TMOUT': '86400', 06:42:38 INFO - 'USER': 'cltbld', 06:42:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:38 INFO - '_': '/tools/buildbot/bin/python'} 06:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:38 INFO - Running setup.py (path:/tmp/pip-1Qd90V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:39 INFO - Running setup.py (path:/tmp/pip-BYyKxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:39 INFO - Running setup.py (path:/tmp/pip-zXwC2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:39 INFO - Running setup.py (path:/tmp/pip-k_6NmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:39 INFO - Running setup.py (path:/tmp/pip-sy1ha0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:39 INFO - Running setup.py (path:/tmp/pip-lxrZXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:39 INFO - Running setup.py (path:/tmp/pip-7F08uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:39 INFO - Running setup.py (path:/tmp/pip-fe7kwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:39 INFO - Running setup.py (path:/tmp/pip-uSGYWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:39 INFO - Running setup.py (path:/tmp/pip-EA5lD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:39 INFO - Running setup.py (path:/tmp/pip-uvC1Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:39 INFO - Running setup.py (path:/tmp/pip-PFy1n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:39 INFO - Running setup.py (path:/tmp/pip-rDA4wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:39 INFO - Running setup.py (path:/tmp/pip-xky4qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:39 INFO - Running setup.py (path:/tmp/pip-iVGIoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:40 INFO - Running setup.py (path:/tmp/pip-CenhJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:40 INFO - Running setup.py (path:/tmp/pip-nxIih2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:42:40 INFO - Running setup.py install for manifestparser 06:42:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Running setup.py install for mozcrash 06:42:40 INFO - Running setup.py install for mozdebug 06:42:40 INFO - Running setup.py install for mozdevice 06:42:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Running setup.py install for mozfile 06:42:40 INFO - Running setup.py install for mozhttpd 06:42:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Running setup.py install for mozinfo 06:42:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Running setup.py install for mozInstall 06:42:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:42:40 INFO - Running setup.py install for mozleak 06:42:41 INFO - Running setup.py install for mozlog 06:42:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:42:41 INFO - Running setup.py install for moznetwork 06:42:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:42:41 INFO - Running setup.py install for mozprocess 06:42:41 INFO - Running setup.py install for mozprofile 06:42:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:42:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:42:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:42:41 INFO - Running setup.py install for mozrunner 06:42:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:42:41 INFO - Running setup.py install for mozscreenshot 06:42:41 INFO - Running setup.py install for moztest 06:42:41 INFO - Running setup.py install for mozversion 06:42:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:42:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:42:41 INFO - Cleaning up... 06:42:41 INFO - Return code: 0 06:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:41 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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:41 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 06:42:41 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 06:42:41 INFO - Using env: {'DISPLAY': ':0', 06:42:41 INFO - 'HOME': '/home/cltbld', 06:42:41 INFO - 'LANG': 'en_US.UTF-8', 06:42:41 INFO - 'LANGUAGE': 'en_US:en', 06:42:41 INFO - 'LOGNAME': 'cltbld', 06:42:41 INFO - 'MAIL': '/var/mail/cltbld', 06:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:41 INFO - 'MOZ_NO_REMOTE': '1', 06:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:41 INFO - 'NO_EM_RESTART': '1', 06:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:41 INFO - 'PWD': '/builds/slave/test', 06:42:41 INFO - 'SHELL': '/bin/bash', 06:42:41 INFO - 'SHLVL': '1', 06:42:41 INFO - 'TERM': 'linux', 06:42:41 INFO - 'TMOUT': '86400', 06:42:41 INFO - 'USER': 'cltbld', 06:42:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:41 INFO - '_': '/tools/buildbot/bin/python'} 06:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:42 INFO - Running setup.py (path:/tmp/pip-6rQ64x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:42 INFO - Running setup.py (path:/tmp/pip-fFa0OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:42 INFO - Running setup.py (path:/tmp/pip-zg9juZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:42 INFO - Running setup.py (path:/tmp/pip-8jvSly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:42 INFO - Running setup.py (path:/tmp/pip-oL3Dvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:42 INFO - Running setup.py (path:/tmp/pip-rTY_oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:42 INFO - Running setup.py (path:/tmp/pip-vvPiS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:42 INFO - Running setup.py (path:/tmp/pip-SXvzsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:42 INFO - Running setup.py (path:/tmp/pip-ZyZ32n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:42 INFO - Running setup.py (path:/tmp/pip-vMVPob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:42 INFO - Running setup.py (path:/tmp/pip-bWN3GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:42 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)) 06:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:42 INFO - Running setup.py (path:/tmp/pip-A1PU_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:43 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)) 06:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:43 INFO - Running setup.py (path:/tmp/pip-T1Y8lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:43 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)) 06:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:43 INFO - Running setup.py (path:/tmp/pip-pt1rhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:43 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)) 06:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:43 INFO - Running setup.py (path:/tmp/pip-09HpJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:43 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)) 06:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:43 INFO - Running setup.py (path:/tmp/pip-jwa9PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:43 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)) 06:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:43 INFO - Running setup.py (path:/tmp/pip-RvJOGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:43 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)) 06:42:43 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)) 06:42:43 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)) 06:42:43 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)) 06:42:43 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)) 06:42:43 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)) 06:42:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:42: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 06:42: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 06:42: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 06:42: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 06:42: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 06:42: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 06:42:45 INFO - Downloading blessings-1.6.tar.gz 06:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:42:45 INFO - Installing collected packages: blessings 06:42:45 INFO - Running setup.py install for blessings 06:42:45 INFO - Successfully installed blessings 06:42:45 INFO - Cleaning up... 06:42:45 INFO - Return code: 0 06:42:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:42:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:45 INFO - Reading from file tmpfile_stdout 06:42:45 INFO - Current package versions: 06:42:45 INFO - argparse == 1.2.1 06:42:45 INFO - blessings == 1.6 06:42:45 INFO - blobuploader == 1.2.4 06:42:45 INFO - docopt == 0.6.1 06:42:45 INFO - functools32 == 3.2.3-2 06:42:45 INFO - jsonschema == 2.5.1 06:42:45 INFO - manifestparser == 1.1 06:42:45 INFO - mozInstall == 1.12 06:42:45 INFO - mozcrash == 0.17 06:42:45 INFO - mozdebug == 0.1 06:42:45 INFO - mozdevice == 0.48 06:42:45 INFO - mozfile == 1.2 06:42:45 INFO - mozhttpd == 0.7 06:42:45 INFO - mozinfo == 0.9 06:42:45 INFO - mozleak == 0.1 06:42:45 INFO - mozlog == 3.3 06:42:45 INFO - moznetwork == 0.27 06:42:45 INFO - mozprocess == 0.23 06:42:45 INFO - mozprofile == 0.28 06:42:45 INFO - mozrunner == 6.12 06:42:45 INFO - mozscreenshot == 0.1 06:42:45 INFO - mozsystemmonitor == 0.3 06:42:45 INFO - moztest == 0.7 06:42:45 INFO - mozversion == 1.4 06:42:45 INFO - psutil == 3.1.1 06:42:45 INFO - requests == 1.2.3 06:42:45 INFO - wsgiref == 0.1.2 06:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:45 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 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:45 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 06:42:45 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 06:42:45 INFO - Using env: {'DISPLAY': ':0', 06:42:45 INFO - 'HOME': '/home/cltbld', 06:42:45 INFO - 'LANG': 'en_US.UTF-8', 06:42:45 INFO - 'LANGUAGE': 'en_US:en', 06:42:45 INFO - 'LOGNAME': 'cltbld', 06:42:45 INFO - 'MAIL': '/var/mail/cltbld', 06:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:45 INFO - 'MOZ_NO_REMOTE': '1', 06:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:45 INFO - 'NO_EM_RESTART': '1', 06:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:45 INFO - 'PWD': '/builds/slave/test', 06:42:45 INFO - 'SHELL': '/bin/bash', 06:42:45 INFO - 'SHLVL': '1', 06:42:45 INFO - 'TERM': 'linux', 06:42:45 INFO - 'TMOUT': '86400', 06:42:45 INFO - 'USER': 'cltbld', 06:42:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:45 INFO - '_': '/tools/buildbot/bin/python'} 06:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 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)) 06:42:45 INFO - Cleaning up... 06:42:46 INFO - Return code: 0 06:42:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, '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': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', '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 06:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:42:46 INFO - Using env: {'DISPLAY': ':0', 06:42:46 INFO - 'HOME': '/home/cltbld', 06:42:46 INFO - 'LANG': 'en_US.UTF-8', 06:42:46 INFO - 'LANGUAGE': 'en_US:en', 06:42:46 INFO - 'LOGNAME': 'cltbld', 06:42:46 INFO - 'MAIL': '/var/mail/cltbld', 06:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:46 INFO - 'MOZ_NO_REMOTE': '1', 06:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:46 INFO - 'NO_EM_RESTART': '1', 06:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:46 INFO - 'PWD': '/builds/slave/test', 06:42:46 INFO - 'SHELL': '/bin/bash', 06:42:46 INFO - 'SHLVL': '1', 06:42:46 INFO - 'TERM': 'linux', 06:42:46 INFO - 'TMOUT': '86400', 06:42:46 INFO - 'USER': 'cltbld', 06:42:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:46 INFO - '_': '/tools/buildbot/bin/python'} 06:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:42:46 INFO - Cleaning up... 06:42:46 INFO - Return code: 0 06:42:46 INFO - Running post-action listener: _resource_record_post_action 06:42:46 INFO - Running post-action listener: _start_resource_monitoring 06:42:46 INFO - Starting resource monitoring. 06:42:46 INFO - [mozharness: 2016-07-24 13:42:46.249271Z] Finished create-virtualenv step (success) 06:42:46 INFO - [mozharness: 2016-07-24 13:42:46.249746Z] Running install step. 06:42:46 INFO - Running pre-action listener: _resource_record_pre_action 06:42:46 INFO - Running main action method: install 06:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:46 INFO - Reading from file tmpfile_stdout 06:42:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:42:46 INFO - Reading from file tmpfile_stdout 06:42:46 INFO - Output received: 06:42:46 INFO - Usage: mozinstall [options] installer 06:42:46 INFO - Options: 06:42:46 INFO - -h, --help show this help message and exit 06:42:46 INFO - -d DEST, --destination=DEST 06:42:46 INFO - Directory to install application into. [default: 06:42:46 INFO - "/builds/slave/test"] 06:42:46 INFO - --app=APP Application being installed. [default: firefox] 06:42:46 INFO - mkdir: /builds/slave/test/build/application 06:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:43:02 INFO - Reading from file tmpfile_stdout 06:43:02 INFO - Output received: 06:43:02 INFO - /builds/slave/test/build/application/firefox/firefox 06:43:02 INFO - Running post-action listener: _resource_record_post_action 06:43:02 INFO - [mozharness: 2016-07-24 13:43:02.918738Z] Finished install step (success) 06:43:02 INFO - [mozharness: 2016-07-24 13:43:02.919014Z] Running run-tests step. 06:43:02 INFO - Running pre-action listener: _resource_record_pre_action 06:43:02 INFO - Running main action method: run_tests 06:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:43:02 INFO - Python 2.7.3 06:43:02 INFO - Return code: 0 06:43:02 INFO - grabbing minidump binary from tooltool 06:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:02 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 0x21f33b0>, '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 0x21f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:43:02 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 06:43:02 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 06:43:02 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 06:43:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:43:02 INFO - Return code: 0 06:43:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:43:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:43:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:43:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:43:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:43:02 INFO - Using env: {'DISPLAY': ':0', 06:43:02 INFO - 'HOME': '/home/cltbld', 06:43:02 INFO - 'LANG': 'en_US.UTF-8', 06:43:02 INFO - 'LANGUAGE': 'en_US:en', 06:43:02 INFO - 'LOGNAME': 'cltbld', 06:43:02 INFO - 'MAIL': '/var/mail/cltbld', 06:43:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:43:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:03 INFO - 'MOZ_NO_REMOTE': '1', 06:43:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:03 INFO - 'NO_EM_RESTART': '1', 06:43:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:03 INFO - 'PWD': '/builds/slave/test', 06:43:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:43:03 INFO - 'SHELL': '/bin/bash', 06:43:03 INFO - 'SHLVL': '1', 06:43:03 INFO - 'TERM': 'linux', 06:43:03 INFO - 'TMOUT': '86400', 06:43:03 INFO - 'USER': 'cltbld', 06:43:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714', 06:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:03 INFO - '_': '/tools/buildbot/bin/python'} 06:43:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:43:03 INFO - mozversion application_buildid: 20160724060326 06:43:03 INFO - mozversion application_changeset: d12890b78b043ccc2445dcef144e982f83b65e5f 06:43:03 INFO - mozversion application_display_name: Nightly 06:43:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:43:03 INFO - mozversion application_name: Firefox 06:43:03 INFO - mozversion application_remotingname: firefox 06:43:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:43:03 INFO - mozversion application_vendor: Mozilla 06:43:03 INFO - mozversion application_version: 50.0a1 06:43:03 INFO - mozversion platform_buildid: 20160724060326 06:43:03 INFO - mozversion platform_changeset: d12890b78b043ccc2445dcef144e982f83b65e5f 06:43:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:43:03 INFO - mozversion platform_version: 50.0a1 06:43:03 INFO - using testdate: 1469367783 06:43:03 INFO - actual date: 1469367783 06:43:03 INFO - starting webserver on 'localhost:41386' 06:43:03 INFO - SUITE-START | Running 2 tests 06:43:03 INFO - TEST-START | dromaeo_css 06:43:03 INFO - operating with platform_type : linux_ 06:43:03 INFO - Initialising browser for dromaeo_css test... 06:43:03 INFO - TEST-INFO | started process 12582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD1Mb8P/profile http://localhost:41386/getInfo.html) 06:43:06 INFO - PROCESS | 12582 | JavaScript error: , line 0: uncaught exception: undefined 06:43:07 INFO - PROCESS | 12582 | __metrics Screen width/height:1600/1200 06:43:07 INFO - PROCESS | 12582 | colorDepth:24 06:43:07 INFO - PROCESS | 12582 | Browser inner width/height: 1024/697 06:43:07 INFO - PROCESS | 12582 | __metrics 06:43:08 INFO - PROCESS | 12582 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:43:08 INFO - PROCESS | 12582 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:43:08 INFO - PROCESS | 12582 | console.error: PushService: 06:43:08 INFO - PROCESS | 12582 | stateChangeProcessEnqueue: Error transitioning state 06:43:08 INFO - PROCESS | 12582 | UnknownError 06:43:09 INFO - TEST-INFO | 12582: exit 0 06:43:09 INFO - Browser initialized. 06:43:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:43:09 INFO - TEST-INFO | started process 12660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD1Mb8P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:21 INFO - PROCESS | 12660 | RSS: Main: 159051776 06:43:21 INFO - PROCESS | 12660 | 06:44:12 INFO - PROCESS | 12660 | 1469367852764 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] 06:46:24 INFO - PROCESS | 12660 | Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41386/tests/dromaeo/cssquery-ext.html) 06:46:25 INFO - PROCESS | 12660 | RSS: Main: 283615232 06:46:25 INFO - PROCESS | 12660 | 06:49:28 INFO - PROCESS | 12660 | Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-ext.html (next: http://localhost:41386/tests/dromaeo/cssquery-jquery.html) 06:49:29 INFO - PROCESS | 12660 | RSS: Main: 246575104 06:49:29 INFO - PROCESS | 12660 | 06:52:31 INFO - PROCESS | 12660 | Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41386/tests/dromaeo/cssquery-mootools.html) 06:52:31 INFO - PROCESS | 12660 | RSS: Main: 185331712 06:52:31 INFO - PROCESS | 12660 | 06:55:34 INFO - PROCESS | 12660 | Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41386/tests/dromaeo/cssquery-prototype.html) 06:55:34 INFO - PROCESS | 12660 | RSS: Main: 185589760 06:55:34 INFO - PROCESS | 12660 | 06:58:37 INFO - PROCESS | 12660 | Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41386/tests/dromaeo/cssquery-yui.html) 06:58:38 INFO - PROCESS | 12660 | RSS: Main: 185659392 06:58:38 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | Cycle 1(1): loaded http://localhost:41386/tests/dromaeo/cssquery-yui.html (next: http://localhost:41386/tests/dromaeo/cssquery-dojo.html) 07:01:41 INFO - PROCESS | 12660 | RSS: Main: 277921792 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | __start_tp_report 07:01:41 INFO - PROCESS | 12660 | _x_x_mozilla_page_load 07:01:41 INFO - PROCESS | 12660 | _x_x_mozilla_page_load_details 07:01:41 INFO - PROCESS | 12660 | |i|pagename|runs| 07:01:41 INFO - PROCESS | 12660 | |0;dojo.html;2583.909563165289;2584.6123081537753;2616.411307455822;2621.6853977522687;2627.3956989892326;4605.355250264965;4657.487676355607;4732.337472753813;4771.8091276348905;4773.116973359926;4641.350210970459;4682.297655351699;4701.576858082772;4712.905741885169;4744.217204161318;4335.6965012449145;4409.426774519316;4410.889727756799;4429.844955426561;4430.26900561407;4364.541723119074;4394.648428125743;4413.337999300099;4432.445944256968;4471.910561788763;4421.09367579647;4454.688171827974;4473.127740090684;4494.348319493672;4500.032493014001;4254.404383386328;4316.287812510932;4393.319035549495;4403.933940990888;4479.328100784892;4266.786660666954;4298.78506074695;4306.267934451151;4310.224159651261;4311.849085282031;4724.976375118103;4736.573708366229;4793.161196790547;4802.18362878308;4810.494898035691;4863.221884498464;5097.8215762448135;5136.897262054776;5142.768575414116;5148.665336753099;5032.899342013139;5057.367829021372;5066.746662666888;5135.152699804527;5140.1004824155625;4768.451628062748;4769.618430525549;4782.187028205213;4793.01743142655;4795.784189711401;5059.797608095635;5127.9230811537855;5255.9211611825085;5265.894682106413;5270.894582108336;4954.628402869799;5025.748712564357;5039.092963266574;5039.395272567315;5045.990801839646;5066.620003499678;5068.214426763858;5121.487851214849;5122.129238029544;5123.5644970177955;4916.70499770015;4965.155923493015;5015.297858299841;5021.899562008739;5025.3718285214345;4896.167651499253;4936.308916751657;4948.554630083309;4996.050750357421;5019.67372120811;4212.094399704079;4219.725717828332;4221.472315960505;4221.810018549111;4256.084941737541;3737.177820879402;3743.21392507571;3754.7934863582764;3763.7929913855;3764.981175094107;4205.432266644025;4349.586789255016;4384.05742765307;4386.517483076859;4433.024734558457;5106.106431374495;5109.514596113363;5118.206677964921;5126.974365128151;5158.974205129025;4368.36658684489;4376.890577735582;4378.233809083397;4383.780810959439;4423.778811059434;4421.005273813366;4518.728876267434;4535.750533720611;4566.840160594364;4634.142683603544;4754.619630429626;4767.856964291007;4777.593904518016;4779.211430113992;4825.155597770447;5106.821261255838;5113.284140220298;5117.8464646060675;5125.923111153261;5126.74366281677;4612.123696497655;4661.394018777537;4696.483386827378;4715.528447155257;4765.73788441639;4966.801327946841;4980.825671101639;4984.476629953802;4995.125852975787;5039.21892106724;5049.343585333883;5052.797888084582;5053.267276244997;5060.316857224375;5105.2086926526445;4762.976185119052;4895.46149923501;4933.210686290176;4943.184374578154;4991.750412479289;4931.137051015986;4955.975220123876;4972.179590367549;4975.825846095369;5016.398032236155;4888.780004899717;4904.288878112582;4904.583110435653;4939.53074457926;4950.45544990058;4851;4865.951340486691;4926.064047830901;4929.014197160654;4943.233798761198;4851.80592776285;4857.854264372075;4869.245266983623;4897.314375987294;4905.386826646669 07:01:41 INFO - PROCESS | 12660 | |1;ext.html;545.2102130927241;577.9017567013605;581.0992960910587;592.1413949772829;606.2088973889075;29098.70901290989;40171.59828401715;40583.18833623326;40794.184116317694;43877;40509.7974510127;40900.38649420261;40966.69849665787;40988.59011409885;40991.59008409915;7359.337659610634;7661.4253930955265;7779.260970207822;7802.33680137189;9947.1544918682;9794;10126.746831329203;10132;10137.290389672726;10138.898611013907;10150.847737283946;10220.744481387988;10230.539625716823;10233.539490722898;10235.488225588728;10161.28870979028;10170.033846784543;10180.643677471253;10190.235732320105;10196.89803101967;9951.701448956543;9983.351082179708;10027.548760305805;10029.348092374044;10039;38790;38811;39119.41320880189;39150.216995660216;39206.80396597999;2898.5797059426263;2923.1961210667237;2977.4640564698348;3010.9247268818453;3045.4670432674416;29060.41879162426;29164.708352916412;29585;29735.70264297351;30892;3349.748768842322;3437.9312413751836;3441.105312618712;3455.6198818129988;3489.4068008438626;259014;260572;262540;262621.9999999981;262669;31785.682143178736;52845.2073218902;53245;53307.20039199415;53354.7332263344;31888.521672174935;33349;33520.832395838355;33606.66393336084;33661.326773464396;14051.156930584199;14192.148471091768;14195.929020354832;14202.928985355007;14203.502877399242;10657;11549.711257218636;11733.647990560126;11781.823272650918;11846.348450835114;7812.882806757903;7822.295993360625;7850.2542258485355;7894.328982036591;7903.486273392211;3112.054965646471;3112.206387371206;3145.386649603305;3162.6204855417036;3170.1916011416943;834.7662654456761;836.7406104107746;899.5502248875562;926.5228407370209;987.5852142100335;27836.721632783414;28419.857900710365;28428.573571396446;28454.288642784097;28940.42119157605;956.6890760502864;962.7737481691797;1005.215931573374;1028.7633844215873;1050.8318669012922;14961.476348327975;15148.621284467976;15154.318055687521;15512.612184695472;15534.922325388301;373841;376706;376792;378052;378176;49338;49949.50050499449;49993.25010124851;50048.74975625172;50101.49898501041;1084.6691759013577;1126.4649291586595;1162.128403697227;1177.240679761549;1183.1067544004393;25981.870090650184;28857.711422886343;29078.854605726836;29690.55464167996;29727.70272297249;48196;48815.267770984174;48953;48985;49037.754811225714;347513;350952;351372;352294;353368;25331.6200257;26038.218853434428;26105.73894261033;27540.311492212855;39026.04869756557;41730.374044389966;42404.5759542413;42517.78741106398;43235;43435.78282108569;35979.28041439209;36037.45943810792;36207;36890;37091;36461.08847278839;37061.44407833939;37656.62343376641;38338.2332353357;40273.59726402698;35525;35852.28295434025;36837.079073023386;37203;37535.62464375321;31394.529082064244;33377.833110835265;33499.665003349655;33947.32105357928;34112.82943585266;25626;25843.870780645975;26073;26151.476970460102;26171.345716357242 07:01:41 INFO - PROCESS | 12660 | |2;jquery.html;343.2191763737495;362.2899117729249;374.9343864823656;376.84172647488055;388.5240580289146;12439.25364478132;17280.913595432023;17580.472585822416;18636.72044919324;18798.436046918614;16499.752503712454;17004;18079.638407231847;18251.45245642633;18255.908720456413;4806.303086052529;5160.045391602547;5201.895962080756;5206.921896171541;5207.270982062514;3762.868299609514;5149.356330458692;5165.560927321182;5786.739596718157;6085.569891075594;6070.028795392738;6105.54208434367;6110.938890611082;6111.449969502743;6114.480269177126;5966.701664916758;6040.516758659319;6061.121137435091;6096.207493025922;6104.420080092428;5157.381114266312;5344.759485823109;5350.464953504657;5351.277577527023;5359.08895487768;21440.571188576298;21813;21841.890790546106;21990.89004554967;22003.889980549993;2095.7799431059825;2140.411386868608;2275.7951784339325;2371.0515793682493;2498.375406148463;13435.798463023062;13443.3950472228;13675.452981880713;13764;13913.652158696113;1741.3469948769211;1748.117200813581;1753.2636292756945;1818.0727828807271;1863.0684657671165;69856.6507167466;71981;72546.63726681385;72750.63624681842;74665.25334746638;9514.19129374011;9718.562664679965;9889.307748457682;10126.797464050678;10154.644587439552;13622.795658065137;13664.52174173919;13714.51999180024;13739.725205495834;13837.238951857744;7799.259070388304;7811.804704882424;7855.921440785519;7996.9200307997335;8032.558209298545;7550.207228241065;7629.809254768564;7880.84238315242;7886.3296619786815;7902;6184.536159787944;6282.937170628235;6319.8104056878365;6382.712777925005;6423.229212494531;1725.4909801608555;1806.1480802200774;1813.8730288879651;1824.379710898301;1825.3155066849931;893.3478560650761;898.9865152022725;900.5767289373983;909.2544113826731;976.4531862157214;17620.823791762174;19206.327778527684;19256.903715481614;19380.224791008484;19568.706469402685;864.0711235421946;875.7898104455012;876.2683159561838;886.1404437695554;887.8135591525852;8999.235065019546;10780.801039402375;10836.987303594015;10837.85034866875;10876.94561527203;377924;383482;383875;387829;388061;76277.61861190769;77836.61081694555;80596;81092.59453702693;83224;903.2051794420868;909.0909090909091;937.9390339628039;944.2587568758491;948.8481842905102;16547.503574892773;17007;17333.653326933138;17386.21762020687;17391.304347825946;36009.45985810267;37134.62865371312;39285;40434.595654043085;41101;50558;50987.49012509827;54087.72956135194;54500.45499544954;54933;7526.623668816428;7595.354394876497;7697.807554811175;7714.807129821799;7894.250046245597;9559.617615295589;11854.407279636156;11991.280523168289;11992.520299187934;12091.939540302243;10130.89869101329;10215.846762298721;10221.795564088825;10550.155987521133;10572.048515633629;4907.803687852446;6373.98016317387;10133.746656333651;10507.422091785025;10516.474176291307;10010.249231307535;10039.799204015733;10084.949575252076;10115.342502737298;10361.4301213434;6743.1908171019795;7009.474289428415;7048.295170482911;7282.67227974753;8088.676452941816;8441.409101362846;10051.195904327782;10190.541425636013;10450.68647940563;10494.317869338469 07:01:41 INFO - PROCESS | 12660 | |3;mootools.html;1262.9684257893546;1360.7550640884642;1422.1324991755027;1467.9045862018975;1629.8696104311657;6726.831829204272;7532.133804612471;7766.456348055638;7784.143744188134;7987.880181797278;7784.416168787336;7825.2174782521715;7829.334506566935;7843.254890785381;7846.450748447611;2108.768035516092;2132.488202831325;2134.231676596424;2136.9038393272263;2137.5617998310386;2062.3915944796245;2110.2719561751246;2114.5136618577735;2131.7548481924546;2133.1680644548637;2095.4866057815857;2108.061912448961;2115.2279418012467;2117.04732870209;2145.7961493658077;2069.6998935154393;2082.4585607741947;2083.2916808285254;2083.427057559183;2085.447356450542;2010.2361102780849;2075.84790441305;2076.5431605046865;2077.7714451410334;2079.365793433002;7688.730894418669;7803.3367163791145;7898.328642065431;7901.762947111539;7915.604219788987;4455.576720211575;4616.561426664462;4623.352730617717;4630.652701047435;4638.489766125724;2694.2725464124774;2817.647794025747;2842.9857850710823;2853.9857300713365;2858.428314337141;937.0863408177041;943.8253923024263;950.7908260182749;952.3714348529937;960.2893858544696;10530.789384212272;10612.097971672418;10620.203484738598;10625.149988000941;10626.946865265701;3928.52857657083;4076.103257283393;4077.9796101019897;4082.714210005271;4278.529361770203;8371.958140209383;8410.579471026547;8423.70517031901;8444.788880278042;8456.11210822867;4551.249043907785;4556.316552517149;4556.635469162459;4558.247889098328;4560.156371071363;3671.6695497405362;4046.251443482965;4184;4191.538930717618;4193.51774545925;3287.6054873414864;3298.125996610852;3415;3425.7773244739014;3428.9828550857087;953.2040745977187;964.7009427077628;984.4880662055691;984.9310548261697;996.1333639733479;704.989425158623;807.1484583764185;815.388458656008;833.829065041665;838.9496630202085;5063.493650634907;5170.896582068338;5273.630845840754;5282.022825777167;5367.355917289872;348.7157966257492;362.9074585980558;363.2335771522086;369.60636921678326;372.13107394234225;3531.6644918732677;3625.3293140768515;3674.81625918703;3695.8336874840697;3751.0809851586537;9350.719478415658;9855.063768941938;9878.901210987942;9891.554880030415;9907.900920990842;9517.095875891779;9608.471534065553;9807.06832850878;9873.950630246803;9888.20894328452;7417.517861338995;7472.551646901204;7473.663685134182;7477.70089196426;7485.176630570633;5051.823186188612;5085.3134826797905;5164.7417629119145;5170.922436163385;5375.489328513785;8833.779155521164;8869.290456763572;8937.374383793072;9014.774630634287;9096.863547046933;9021.278297736035;9180.403273787182;9189.816203675755;9298.163165315154;9358.766030849283;5853.9121913172185;6079.3008803988105;6224.595401298901;6271.153394291712;6419.871602567829;6862.759803406857;7032.085828842218;7045.11936007999;7178.210396856446;7186.712531498891;6664.7000884959325;6742.797716068526;6785.423239024541;6848.486363522856;6930.44556435494;6799.660016999229;6821.386075253251;6822.420094291842;6832.590044597141;6841.897371539331;6120.265568131853;6200.627962322275;6205.379462053758;6209.379062093754;6212.4408803207925;4431.778411079497;4496.505384407647;4551.977240113911;4588.220002599499;4636.907261854812;4490.753008584559;4527.705699129678;4618.237990731492;4622.2835460503675;4719.05618876233 07:01:41 INFO - PROCESS | 12660 | |4;prototype.html;290.69477049098447;291.0830882719433;302.73964390624064;305.8470764617691;308.0988109778896;4804.759762011903;4911.312416261726;4931.284963680264;4942.258661200822;4945.233488809231;4825.083234185511;4845.927311090337;4894.3147959285725;4908.656394052417;4913.53321434464;3600.8657272959067;3731.8507259709713;3746.6440688134585;3754.7609288934586;3763.9247215055684;3733.6932073774096;3752.5496940367193;3830.253100645375;3867.9806600967095;3881.6700580450697;3794.6964242860504;3801.752886062411;3802.2965751335955;3831.63599458051;3853.2293541291715;3565.144365352297;3739.6447337502896;3804.7063998240733;3838.750481218726;3849.268638958617;3296.934061318784;3300.6864347886913;3310.4372256716415;3318.4026875162463;3325.7505687073567;4677.368555245032;4699.929501057487;4701.177293973541;4708.764561771898;4723.362346083303;4143.274926887812;4265.0403659176745;4276.722013069171;4288.31386978082;4293.806778694966;5047.949520504784;5051.131081499831;5058.949410505885;5060.84817455477;5065.670731402447;3591.2278860044953;3613.9819300903328;3625.456181572759;3639.4358874374516;3642.653947874948;5021.949780502185;5205.011047900886;5242.16125419931;5327.38735045467;5373.623846330758;3655.8720444784835;3678.4850120983083;3681.116532032293;3681.963180368162;3694.946940122052;3757.6618104370737;3760.7367484275837;3767.5102236709054;3770.547534295847;3785.690728655518;4267.487901451784;4302.763348015889;4315.805788739514;4323.351497275434;4333.58830911063;4923.409190897044;4983.654413308386;5032.949670503322;5049.31834202378;5061.898762024739;1270.9872901271053;1288.5940928607458;1291.876067820983;1300.1159211735921;1311.6196303072193;777.906651201848;817.7015389382951;821.199330652609;821.6631181215673;828.1470085811624;4273.995611031405;4326.372675961968;4406.889827754332;4472.217361961643;4484.529124441952;5200.479952004845;5207.739613019334;5233.371995360581;5237.3453318335205;5241.532370936144;4441.222786012435;4443.688941774045;4449.110177964355;4507.977460112678;4513.435820522434;2651.8331933949385;2723.128598848389;2769.7645700115313;2774.84843789829;2789.2050765531726;4867.683600565952;4899.730514821719;4901.627544287605;4903.975480122648;4935.555799977948;5098.745062746848;5290.338707661543;5332.06688829461;5380.381256155514;5400.513953744182;4848.951510484921;4856.757162141949;4862.51374862518;4868.271763523969;4880.463149053601;5155.716435596079;5201.453847346125;5236.790528378974;5240.318758561362;5251.291075704884;4938.135826230324;5089.592832573459;5098.286239926488;5104.259882316969;5105.489451055013;4868.732219727949;4875.975620122019;4885.874644529641;4890.902181956412;4904.362432883845;3654.6893514051603;3670.541182352206;3697.9815100924325;3730;3741;5042.949570504248;5302.681839089667;5322.654027488201;5335.119705248746;5352.197170424468;5090.770915308746;5094.6688465249645;5102.188723003281;5103.642745007814;5137.280780690631;5079.492050794891;5091.719955402488;5097.413797413345;5099.87250318745;5115.104856650146;4810.470848206624;4961;4962.280469331999;4977.701337919736;4986.276989836526;4828.696252012008;4976.377952755905;5060.886604946906;5086.898262034812;5087.872803179802;4825.662203645711;4840.201366774443;4842.7336496493035;4870.31815545831;4891.168501354707 07:01:41 INFO - PROCESS | 12660 | |5;yui.html;654.6105067484847;671.8286836856604;672.8620632770283;727.6434547071937;767.4282659418732;12692.555760548383;13832.585022449317;13836.23900685462;13845.58463246103;13919.721605567882;13694.863051369482;14231.217283049427;14520;14835.332410041547;15002.549923502285;639.6993413095837;780.3172224303748;798.8362385710944;798.9400794940374;799.2886331165267;757.8143354878035;791.513219370089;794.66226853587;795.1055063054064;795.8806179073157;832.2010869565195;834.3700506117873;834.8121672623672;835.1106072033265;835.3192148399036;653.9313372095957;823.27551754456;823.6170180865867;823.9299659528947;824.0523398092182;578.2627150383295;595.0360416125903;595.2767387624015;597.2027343496437;598.1118039711025;13051.738965220737;13063.86936130636;13066.477340906353;13076.08467407282;13124.934375328157;12150.45322960469;12197.69084474349;12372.628821135291;12474.81287780684;12840.229586224856;11549.13381496391;11566.42167891602;11632.476538555786;11859.169858109935;12007.3395963222;4017.5580686124504;4074.6740260779065;4098.815553300109;4157.646600039;4204.3693445983345;58782.41217587812;59997.40002599962;60002.699986499785;60710.696446517926;60721.6963915182;9708.75728106803;10062.295639305325;10178.389296642225;10250.794984100425;10337.793244135226;18990;19359.709604355947;19369.709454358195;19375.3218637347;19376.321828736207;6633.966830165915;6735.8989615155815;6782.898256526156;6797.5581587196675;7049.154101507852;3656.0859785053735;3668.614795446493;3734.5705243896755;3760.7555508891833;3767.962320376816;2778.263760103574;2896.9130926072253;2903.419316136781;2903.564465330175;2906.433245517104;533.2481201505858;543.5189856976605;550.4770468055283;551.9889602207934;562.5780664501624;433.3521385528655;488.64329039801146;520.9088409528317;522.516672078326;595.9642421454727;7661;7817.788242822372;7843.705643629689;7865.213478652204;8127.959360203161;458.33999041380304;479.05386860949346;505.9595232381401;534.3801190618864;564.1650357470966;3762.6237376262156;3799.549896416568;3815.1415931415763;3844.2503711776494;4020.1758639478835;55696.82273829479;56731.716341418854;75511.62244188854;99451;99782;78983;79110.60444697854;79769;81833;81934.59032704799;45872.082558348644;71069.2893071073;71600;71633.6418317905;73401.63299183683;7094.042637975775;7303.926960730537;7443.55338679681;7462.850742985219;7646.4265180112825;31514.684853151175;34919.82540087283;40436.79781601073;40723.38914916338;41913;56528.434715652314;60965;62198.378016219256;64982;65471.34528654652;9699.757506062122;10395.16838652921;10606.628767993083;10667.626633067805;10877.347359158475;10737.731556711145;10751.569937202737;11089.27919685218;11100.444977751242;11350.60272890478;9860.901390985999;10072.647457338959;10088.142507886912;10183.287169898036;10470.685879423629;9269.212116970133;9517.619295228113;9532.428054316762;9544.42733435996;9619.90380096218;9294.628214871329;9309.301802364986;9337.20633746112;9597.90402095998;10206.59173633076;9070.138336857988;9094.454332740057;9128.589213485277;9249.12133347331;9273.768155796159;9167;9510.493671074388;9599.752496245263;9603.759906002406;9651.227901767983 07:01:41 INFO - PROCESS | 12660 | __end_tp_report 07:01:41 INFO - PROCESS | 12660 | __start_cc_report 07:01:41 INFO - PROCESS | 12660 | _x_x_mozilla_cycle_collect,1193 07:01:41 INFO - PROCESS | 12660 | __end_cc_report 07:01:41 INFO - PROCESS | 12660 | __startTimestamp1469368901499__endTimestamp 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | ------- Summary: start ------- 07:01:41 INFO - PROCESS | 12660 | Number of tests: 6 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | [#0] dojo.html Cycles:165 Average:4683.26 Median:4795.78 stddev:496.39 (10.4%) stddev-sans-first:469.80 07:01:41 INFO - PROCESS | 12660 | Values: 2583.9 2584.6 2616.4 2621.7 2627.4 4605.4 4657.5 4732.3 4771.8 4773.1 4641.4 4682.3 4701.6 4712.9 4744.2 4335.7 4409.4 4410.9 4429.8 4430.3 4364.5 4394.6 4413.3 4432.4 4471.9 4421.1 4454.7 4473.1 4494.3 4500.0 4254.4 4316.3 4393.3 4403.9 4479.3 4266.8 4298.8 4306.3 4310.2 4311.8 4725.0 4736.6 4793.2 4802.2 4810.5 4863.2 5097.8 5136.9 5142.8 5148.7 5032.9 5057.4 5066.7 5135.2 5140.1 4768.5 4769.6 4782.2 4793.0 4795.8 5059.8 5127.9 5255.9 5265.9 5270.9 4954.6 5025.7 5039.1 5039.4 5046.0 5066.6 5068.2 5121.5 5122.1 5123.6 4916.7 4965.2 5015.3 5021.9 5025.4 4896.2 4936.3 4948.6 4996.1 5019.7 4212.1 4219.7 4221.5 4221.8 4256.1 3737.2 3743.2 3754.8 3763.8 3765.0 4205.4 4349.6 4384.1 4386.5 4433.0 5106.1 5109.5 5118.2 5127.0 5159.0 4368.4 4376.9 4378.2 4383.8 4423.8 4421.0 4518.7 4535.8 4566.8 4634.1 4754.6 4767.9 4777.6 4779.2 4825.2 5106.8 5113.3 5117.8 5125.9 5126.7 4612.1 4661.4 4696.5 4715.5 4765.7 4966.8 4980.8 4984.5 4995.1 5039.2 5049.3 5052.8 5053.3 5060.3 5105.2 4763.0 4895.5 4933.2 4943.2 4991.8 4931.1 4956.0 4972.2 4975.8 5016.4 4888.8 4904.3 4904.6 4939.5 4950.5 4851.0 4866.0 4926.1 4929.0 4943.2 4851.8 4857.9 4869.2 4897.3 4905.4 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | [#1] ext.html Cycles:180 Average:47997.43 Median:34030.08 stddev:87807.31 (258.0%) stddev-sans-first:87981.35 07:01:41 INFO - PROCESS | 12660 | Values: 545.2 577.9 581.1 592.1 606.2 29098.7 40171.6 40583.2 40794.2 43877.0 40509.8 40900.4 40966.7 40988.6 40991.6 7359.3 7661.4 7779.3 7802.3 9947.2 9794.0 10126.7 10132.0 10137.3 10138.9 10150.8 10220.7 10230.5 10233.5 10235.5 10161.3 10170.0 10180.6 10190.2 10196.9 9951.7 9983.4 10027.5 10029.3 10039.0 38790.0 38811.0 39119.4 39150.2 39206.8 2898.6 2923.2 2977.5 3010.9 3045.5 29060.4 29164.7 29585.0 29735.7 30892.0 3349.7 3437.9 3441.1 3455.6 3489.4 259014.0 260572.0 262540.0 262622.0 262669.0 31785.7 52845.2 53245.0 53307.2 53354.7 31888.5 33349.0 33520.8 33606.7 33661.3 14051.2 14192.1 14195.9 14202.9 14203.5 10657.0 11549.7 11733.6 11781.8 11846.3 7812.9 7822.3 7850.3 7894.3 7903.5 3112.1 3112.2 3145.4 3162.6 3170.2 834.8 836.7 899.6 926.5 987.6 27836.7 28419.9 28428.6 28454.3 28940.4 956.7 962.8 1005.2 1028.8 1050.8 14961.5 15148.6 15154.3 15512.6 15534.9 373841.0 376706.0 376792.0 378052.0 378176.0 49338.0 49949.5 49993.3 50048.7 50101.5 1084.7 1126.5 1162.1 1177.2 1183.1 25981.9 28857.7 29078.9 29690.6 29727.7 48196.0 48815.3 48953.0 48985.0 49037.8 347513.0 350952.0 351372.0 352294.0 353368.0 25331.6 26038.2 26105.7 27540.3 39026.0 41730.4 42404.6 42517.8 43235.0 43435.8 35979.3 36037.5 36207.0 36890.0 37091.0 36461.1 37061.4 37656.6 38338.2 40273.6 35525.0 35852.3 36837.1 37203.0 37535.6 31394.5 33377.8 33499.7 33947.3 34112.8 25626.0 25843.9 26073.0 26151.5 26171.3 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | [#2] jquery.html Cycles:180 Average:24790.15 Median:39859.80 stddev:63585.27 (159.5%) stddev-sans-first:63737.15 07:01:41 INFO - PROCESS | 12660 | Values: 343.2 362.3 374.9 376.8 388.5 12439.3 17280.9 17580.5 18636.7 18798.4 16499.8 17004.0 18079.6 18251.5 18255.9 4806.3 5160.0 5201.9 5206.9 5207.3 3762.9 5149.4 5165.6 5786.7 6085.6 6070.0 6105.5 6110.9 6111.4 6114.5 5966.7 6040.5 6061.1 6096.2 6104.4 5157.4 5344.8 5350.5 5351.3 5359.1 21440.6 21813.0 21841.9 21990.9 22003.9 2095.8 2140.4 2275.8 2371.1 2498.4 13435.8 13443.4 13675.5 13764.0 13913.7 1741.3 1748.1 1753.3 1818.1 1863.1 69856.7 71981.0 72546.6 72750.6 74665.3 9514.2 9718.6 9889.3 10126.8 10154.6 13622.8 13664.5 13714.5 13739.7 13837.2 7799.3 7811.8 7855.9 7996.9 8032.6 7550.2 7629.8 7880.8 7886.3 7902.0 6184.5 6282.9 6319.8 6382.7 6423.2 1725.5 1806.1 1813.9 1824.4 1825.3 893.3 899.0 900.6 909.3 976.5 17620.8 19206.3 19256.9 19380.2 19568.7 864.1 875.8 876.3 886.1 887.8 8999.2 10780.8 10837.0 10837.9 10876.9 377924.0 383482.0 383875.0 387829.0 388061.0 76277.6 77836.6 80596.0 81092.6 83224.0 903.2 909.1 937.9 944.3 948.8 16547.5 17007.0 17333.7 17386.2 17391.3 36009.5 37134.6 39285.0 40434.6 41101.0 50558.0 50987.5 54087.7 54500.5 54933.0 7526.6 7595.4 7697.8 7714.8 7894.3 9559.6 11854.4 11991.3 11992.5 12091.9 10130.9 10215.8 10221.8 10550.2 10572.0 4907.8 6374.0 10133.7 10507.4 10516.5 10010.2 10039.8 10084.9 10115.3 10361.4 6743.2 7009.5 7048.3 7282.7 8088.7 8441.4 10051.2 10190.5 10450.7 10494.3 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | [#3] mootools.html Cycles:180 Average:5058.99 Median:5222.28 stddev:2907.50 (55.7%) stddev-sans-first:2901.66 07:01:41 INFO - PROCESS | 12660 | Values: 1263.0 1360.8 1422.1 1467.9 1629.9 6726.8 7532.1 7766.5 7784.1 7987.9 7784.4 7825.2 7829.3 7843.3 7846.5 2108.8 2132.5 2134.2 2136.9 2137.6 2062.4 2110.3 2114.5 2131.8 2133.2 2095.5 2108.1 2115.2 2117.0 2145.8 2069.7 2082.5 2083.3 2083.4 2085.4 2010.2 2075.8 2076.5 2077.8 2079.4 7688.7 7803.3 7898.3 7901.8 7915.6 4455.6 4616.6 4623.4 4630.7 4638.5 2694.3 2817.6 2843.0 2854.0 2858.4 937.1 943.8 950.8 952.4 960.3 10530.8 10612.1 10620.2 10625.1 10626.9 3928.5 4076.1 4078.0 4082.7 4278.5 8372.0 8410.6 8423.7 8444.8 8456.1 4551.2 4556.3 4556.6 4558.2 4560.2 3671.7 4046.3 4184.0 4191.5 4193.5 3287.6 3298.1 3415.0 3425.8 3429.0 953.2 964.7 984.5 984.9 996.1 705.0 807.1 815.4 833.8 838.9 5063.5 5170.9 5273.6 5282.0 5367.4 348.7 362.9 363.2 369.6 372.1 3531.7 3625.3 3674.8 3695.8 3751.1 9350.7 9855.1 9878.9 9891.6 9907.9 9517.1 9608.5 9807.1 9874.0 9888.2 7417.5 7472.6 7473.7 7477.7 7485.2 5051.8 5085.3 5164.7 5170.9 5375.5 8833.8 8869.3 8937.4 9014.8 9096.9 9021.3 9180.4 9189.8 9298.2 9358.8 5853.9 6079.3 6224.6 6271.2 6419.9 6862.8 7032.1 7045.1 7178.2 7186.7 6664.7 6742.8 6785.4 6848.5 6930.4 6799.7 6821.4 6822.4 6832.6 6841.9 6120.3 6200.6 6205.4 6209.4 6212.4 4431.8 4496.5 4552.0 4588.2 4636.9 4490.8 4527.7 4618.2 4622.3 4719.1 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | [#4] prototype.html Cycles:180 Average:4202.31 Median:4841.47 stddev:1223.18 (25.3%) stddev-sans-first:1190.86 07:01:41 INFO - PROCESS | 12660 | Values: 290.7 291.1 302.7 305.8 308.1 4804.8 4911.3 4931.3 4942.3 4945.2 4825.1 4845.9 4894.3 4908.7 4913.5 3600.9 3731.9 3746.6 3754.8 3763.9 3733.7 3752.5 3830.3 3868.0 3881.7 3794.7 3801.8 3802.3 3831.6 3853.2 3565.1 3739.6 3804.7 3838.8 3849.3 3296.9 3300.7 3310.4 3318.4 3325.8 4677.4 4699.9 4701.2 4708.8 4723.4 4143.3 4265.0 4276.7 4288.3 4293.8 5047.9 5051.1 5058.9 5060.8 5065.7 3591.2 3614.0 3625.5 3639.4 3642.7 5021.9 5205.0 5242.2 5327.4 5373.6 3655.9 3678.5 3681.1 3682.0 3694.9 3757.7 3760.7 3767.5 3770.5 3785.7 4267.5 4302.8 4315.8 4323.4 4333.6 4923.4 4983.7 5032.9 5049.3 5061.9 1271.0 1288.6 1291.9 1300.1 1311.6 777.9 817.7 821.2 821.7 828.1 4274.0 4326.4 4406.9 4472.2 4484.5 5200.5 5207.7 5233.4 5237.3 5241.5 4441.2 4443.7 4449.1 4508.0 4513.4 2651.8 2723.1 2769.8 2774.8 2789.2 4867.7 4899.7 4901.6 4904.0 4935.6 5098.7 5290.3 5332.1 5380.4 5400.5 4849.0 4856.8 4862.5 4868.3 4880.5 5155.7 5201.5 5236.8 5240.3 5251.3 4938.1 5089.6 5098.3 5104.3 5105.5 4868.7 4876.0 4885.9 4890.9 4904.4 3654.7 3670.5 3698.0 3730.0 3741.0 5042.9 5302.7 5322.7 5335.1 5352.2 5090.8 5094.7 5102.2 5103.6 5137.3 5079.5 5091.7 5097.4 5099.9 5115.1 4810.5 4961.0 4962.3 4977.7 4986.3 4828.7 4976.4 5060.9 5086.9 5087.9 4825.7 4840.2 4842.7 4870.3 4891.2 07:01:41 INFO - PROCESS | 12660 | 07:01:41 INFO - PROCESS | 12660 | [#5] yui.html Cycles:180 Average:16419.13 Median:28654.99 stddev:22940.96 (80.1%) stddev-sans-first:22974.78 07:01:41 INFO - PROCESS | 12660 | Values: 654.6 671.8 672.9 727.6 767.4 12692.6 13832.6 13836.2 13845.6 13919.7 13694.9 14231.2 14520.0 14835.3 15002.5 639.7 780.3 798.8 798.9 799.3 757.8 791.5 794.7 795.1 795.9 832.2 834.4 834.8 835.1 835.3 653.9 823.3 823.6 823.9 824.1 578.3 595.0 595.3 597.2 598.1 13051.7 13063.9 13066.5 13076.1 13124.9 12150.5 12197.7 12372.6 12474.8 12840.2 11549.1 11566.4 11632.5 11859.2 12007.3 4017.6 4074.7 4098.8 4157.6 4204.4 58782.4 59997.4 60002.7 60710.7 60721.7 9708.8 10062.3 10178.4 10250.8 10337.8 18990.0 19359.7 19369.7 19375.3 19376.3 6634.0 6735.9 6782.9 6797.6 7049.2 3656.1 3668.6 3734.6 3760.8 3768.0 2778.3 2896.9 2903.4 2903.6 2906.4 533.2 543.5 550.5 552.0 562.6 433.4 488.6 520.9 522.5 596.0 7661.0 7817.8 7843.7 7865.2 8128.0 458.3 479.1 506.0 534.4 564.2 3762.6 3799.5 3815.1 3844.3 4020.2 55696.8 56731.7 75511.6 99451.0 99782.0 78983.0 79110.6 79769.0 81833.0 81934.6 45872.1 71069.3 71600.0 71633.6 73401.6 7094.0 7303.9 7443.6 7462.9 7646.4 31514.7 34919.8 40436.8 40723.4 41913.0 56528.4 60965.0 62198.4 64982.0 65471.3 9699.8 10395.2 10606.6 10667.6 10877.3 10737.7 10751.6 11089.3 11100.4 11350.6 9860.9 10072.6 10088.1 10183.3 10470.7 9269.2 9517.6 9532.4 9544.4 9619.9 9294.6 9309.3 9337.2 9597.9 10206.6 9070.1 9094.5 9128.6 9249.1 9273.8 9167.0 9510.5 9599.8 9603.8 9651.2 07:01:41 INFO - PROCESS | 12660 | -------- Summary: end -------- 07:01:41 INFO - PROCESS | 12660 | 07:01:42 INFO - TEST-INFO | 12660: exit 0 07:01:42 INFO - TEST-OK | dromaeo_css | took 1119177ms 07:01:42 INFO - TEST-START | kraken 07:01:42 INFO - operating with platform_type : linux_ 07:01:42 INFO - Initialising browser for kraken test... 07:01:42 INFO - TEST-INFO | started process 12850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv_OdHz/profile http://localhost:41386/getInfo.html) 07:01:45 INFO - PROCESS | 12850 | JavaScript error: , line 0: uncaught exception: undefined 07:01:46 INFO - PROCESS | 12850 | __metrics Screen width/height:1600/1200 07:01:46 INFO - PROCESS | 12850 | colorDepth:24 07:01:46 INFO - PROCESS | 12850 | Browser inner width/height: 1024/697 07:01:46 INFO - PROCESS | 12850 | __metrics 07:01:47 INFO - PROCESS | 12850 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:01:47 INFO - PROCESS | 12850 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:01:48 INFO - TEST-INFO | 12850: exit 0 07:01:48 INFO - Browser initialized. 07:01:48 INFO - Running cycle 1/1 for kraken test... 07:01:48 INFO - TEST-INFO | started process 12927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv_OdHz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:00 INFO - PROCESS | 12927 | RSS: Main: 159391744 07:02:00 INFO - PROCESS | 12927 | 07:02:02 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-beat-detection) 07:02:03 INFO - PROCESS | 12927 | RSS: Main: 215179264 07:02:03 INFO - PROCESS | 12927 | 07:02:06 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-dft) 07:02:07 INFO - PROCESS | 12927 | RSS: Main: 193658880 07:02:07 INFO - PROCESS | 12927 | 07:02:10 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-fft) 07:02:11 INFO - PROCESS | 12927 | RSS: Main: 271310848 07:02:11 INFO - PROCESS | 12927 | 07:02:13 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41386/tests/kraken/driver.html?testName=audio-oscillator) 07:02:13 INFO - PROCESS | 12927 | RSS: Main: 181653504 07:02:13 INFO - PROCESS | 12927 | 07:02:16 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:02:16 INFO - PROCESS | 12927 | RSS: Main: 186519552 07:02:16 INFO - PROCESS | 12927 | 07:02:19 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41386/tests/kraken/driver.html?testName=imaging-darkroom) 07:02:20 INFO - PROCESS | 12927 | RSS: Main: 223068160 07:02:20 INFO - PROCESS | 12927 | 07:02:23 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41386/tests/kraken/driver.html?testName=imaging-desaturate) 07:02:24 INFO - PROCESS | 12927 | RSS: Main: 222842880 07:02:24 INFO - PROCESS | 12927 | 07:02:27 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41386/tests/kraken/driver.html?testName=json-parse-financial) 07:02:28 INFO - PROCESS | 12927 | RSS: Main: 221831168 07:02:28 INFO - PROCESS | 12927 | 07:02:29 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:02:30 INFO - PROCESS | 12927 | RSS: Main: 186847232 07:02:30 INFO - PROCESS | 12927 | 07:02:32 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:02:33 INFO - PROCESS | 12927 | RSS: Main: 193957888 07:02:33 INFO - PROCESS | 12927 | 07:02:35 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:02:35 INFO - PROCESS | 12927 | RSS: Main: 196399104 07:02:35 INFO - PROCESS | 12927 | 07:02:38 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:02:39 INFO - PROCESS | 12927 | RSS: Main: 190447616 07:02:39 INFO - PROCESS | 12927 | 07:02:42 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:02:42 INFO - PROCESS | 12927 | RSS: Main: 194469888 07:02:42 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:41386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41386/tests/kraken/driver.html?testName=ai-astar) 07:02:44 INFO - PROCESS | 12927 | RSS: Main: 245452800 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | __start_tp_report 07:02:44 INFO - PROCESS | 12927 | _x_x_mozilla_page_load 07:02:44 INFO - PROCESS | 12927 | _x_x_mozilla_page_load_details 07:02:44 INFO - PROCESS | 12927 | |i|pagename|runs| 07:02:44 INFO - PROCESS | 12927 | |0;ai-astar;104;113;114;114;112;114;115;112;113;116 07:02:44 INFO - PROCESS | 12927 | |1;audio-beat-detection;142;123;127;181;123;124;155;123;162;122 07:02:44 INFO - PROCESS | 12927 | |2;audio-dft;162;161;162;160;161;161;161;160;161;158 07:02:44 INFO - PROCESS | 12927 | |3;audio-fft;75;76;75;114;75;75;75;75;104;75 07:02:44 INFO - PROCESS | 12927 | |4;audio-oscillator;84;87;119;85;85;87;132;85;85;128 07:02:44 INFO - PROCESS | 12927 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 07:02:44 INFO - PROCESS | 12927 | |6;imaging-darkroom;146;146;145;145;147;148;146;147;146;146 07:02:44 INFO - PROCESS | 12927 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;95 07:02:44 INFO - PROCESS | 12927 | |8;json-parse-financial;72;62;62;61;62;63;62;62;61;63 07:02:44 INFO - PROCESS | 12927 | |9;json-stringify-tinderbox;67;66;65;65;66;65;67;66;66;66 07:02:44 INFO - PROCESS | 12927 | |10;stanford-crypto-aes;79;80;78;79;80;79;79;78;78;83 07:02:44 INFO - PROCESS | 12927 | |11;stanford-crypto-ccm;133;131;138;137;128;129;135;128;208;132 07:02:44 INFO - PROCESS | 12927 | |12;stanford-crypto-pbkdf2;163;165;161;164;161;165;161;163;161;160 07:02:44 INFO - PROCESS | 12927 | |13;stanford-crypto-sha256-iterative;66;67;66;68;65;65;66;69;66;66 07:02:44 INFO - PROCESS | 12927 | __end_tp_report 07:02:44 INFO - PROCESS | 12927 | __start_cc_report 07:02:44 INFO - PROCESS | 12927 | _x_x_mozilla_cycle_collect,1944 07:02:44 INFO - PROCESS | 12927 | __end_cc_report 07:02:44 INFO - PROCESS | 12927 | __startTimestamp1469368964686__endTimestamp 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | ------- Summary: start ------- 07:02:44 INFO - PROCESS | 12927 | Number of tests: 14 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.30 (2.9%) stddev-sans-first:1.32 07:02:44 INFO - PROCESS | 12927 | Values: 104.0 113.0 114.0 114.0 112.0 114.0 115.0 112.0 113.0 116.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:134.50 stddev:21.02 (15.6%) stddev-sans-first:22.25 07:02:44 INFO - PROCESS | 12927 | Values: 142.0 123.0 127.0 181.0 123.0 124.0 155.0 123.0 162.0 122.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 07:02:44 INFO - PROCESS | 12927 | Values: 162.0 161.0 162.0 160.0 161.0 161.0 161.0 160.0 161.0 158.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.48 (19.3%) stddev-sans-first:15.14 07:02:44 INFO - PROCESS | 12927 | Values: 75.0 76.0 75.0 114.0 75.0 75.0 75.0 75.0 104.0 75.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.00 stddev:20.03 (23.6%) stddev-sans-first:20.62 07:02:44 INFO - PROCESS | 12927 | Values: 84.0 87.0 119.0 85.0 85.0 87.0 132.0 85.0 85.0 128.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:02:44 INFO - PROCESS | 12927 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:02:44 INFO - PROCESS | 12927 | Values: 146.0 146.0 145.0 145.0 147.0 148.0 146.0 147.0 146.0 146.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:02:44 INFO - PROCESS | 12927 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.00 stddev:3.23 (5.2%) stddev-sans-first:0.71 07:02:44 INFO - PROCESS | 12927 | Values: 72.0 62.0 62.0 61.0 62.0 63.0 62.0 62.0 61.0 63.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 07:02:44 INFO - PROCESS | 12927 | Values: 67.0 66.0 65.0 65.0 66.0 65.0 67.0 66.0 66.0 66.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:1.49 (1.9%) stddev-sans-first:1.58 07:02:44 INFO - PROCESS | 12927 | Values: 79.0 80.0 78.0 79.0 80.0 79.0 79.0 78.0 78.0 83.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:134.00 stddev:24.19 (18.0%) stddev-sans-first:25.52 07:02:44 INFO - PROCESS | 12927 | Values: 133.0 131.0 138.0 137.0 128.0 129.0 135.0 128.0 208.0 132.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 07:02:44 INFO - PROCESS | 12927 | Values: 163.0 165.0 161.0 164.0 161.0 165.0 161.0 163.0 161.0 160.0 07:02:44 INFO - PROCESS | 12927 | 07:02:44 INFO - PROCESS | 12927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 07:02:44 INFO - PROCESS | 12927 | Values: 66.0 67.0 66.0 68.0 65.0 65.0 66.0 69.0 66.0 66.0 07:02:44 INFO - PROCESS | 12927 | -------- Summary: end -------- 07:02:44 INFO - PROCESS | 12927 | 07:02:45 INFO - TEST-INFO | 12927: exit 0 07:02:45 INFO - TEST-OK | kraken | took 63418ms 07:02:45 INFO - SUITE-END | took 1182s 07:02:45 INFO - Completed test suite (00:19:42) 07:02:45 INFO - javascript benchmark 07:02:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.909563165289, 2584.6123081537753, 2616.411307455822, 2621.6853977522687, 2627.3956989892326, 4605.355250264965, 4657.487676355607, 4732.337472753813, 4771.8091276348905, 4773.116973359926, 4641.350210970459, 4682.297655351699, 4701.576858082772, 4712.905741885169, 4744.217204161318, 4335.6965012449145, 4409.426774519316, 4410.889727756799, 4429.844955426561, 4430.26900561407, 4364.541723119074, 4394.648428125743, 4413.337999300099, 4432.445944256968, 4471.910561788763, 4421.09367579647, 4454.688171827974, 4473.127740090684, 4494.348319493672, 4500.032493014001, 4254.404383386328, 4316.287812510932, 4393.319035549495, 4403.933940990888, 4479.328100784892, 4266.786660666954, 4298.78506074695, 4306.267934451151, 4310.224159651261, 4311.849085282031, 4724.976375118103, 4736.573708366229, 4793.161196790547, 4802.18362878308, 4810.494898035691, 4863.221884498464, 5097.8215762448135, 5136.897262054776, 5142.768575414116, 5148.665336753099, 5032.899342013139, 5057.367829021372, 5066.746662666888, 5135.152699804527, 5140.1004824155625, 4768.451628062748, 4769.618430525549, 4782.187028205213, 4793.01743142655, 4795.784189711401, 5059.797608095635, 5127.9230811537855, 5255.9211611825085, 5265.894682106413, 5270.894582108336, 4954.628402869799, 5025.748712564357, 5039.092963266574, 5039.395272567315, 5045.990801839646, 5066.620003499678, 5068.214426763858, 5121.487851214849, 5122.129238029544, 5123.5644970177955, 4916.70499770015, 4965.155923493015, 5015.297858299841, 5021.899562008739, 5025.3718285214345, 4896.167651499253, 4936.308916751657, 4948.554630083309, 4996.050750357421, 5019.67372120811, 4212.094399704079, 4219.725717828332, 4221.472315960505, 4221.810018549111, 4256.084941737541, 3737.177820879402, 3743.21392507571, 3754.7934863582764, 3763.7929913855, 3764.981175094107, 4205.432266644025, 4349.586789255016, 4384.05742765307, 4386.517483076859, 4433.024734558457, 5106.106431374495, 5109.514596113363, 5118.206677964921, 5126.974365128151, 5158.974205129025, 4368.36658684489, 4376.890577735582, 4378.233809083397, 4383.780810959439, 4423.778811059434, 4421.005273813366, 4518.728876267434, 4535.750533720611, 4566.840160594364, 4634.142683603544, 4754.619630429626, 4767.856964291007, 4777.593904518016, 4779.211430113992, 4825.155597770447, 5106.821261255838, 5113.284140220298, 5117.8464646060675, 5125.923111153261, 5126.74366281677, 4612.123696497655, 4661.394018777537, 4696.483386827378, 4715.528447155257, 4765.73788441639, 4966.801327946841, 4980.825671101639, 4984.476629953802, 4995.125852975787, 5039.21892106724, 5049.343585333883, 5052.797888084582, 5053.267276244997, 5060.316857224375, 5105.2086926526445, 4762.976185119052, 4895.46149923501, 4933.210686290176, 4943.184374578154, 4991.750412479289, 4931.137051015986, 4955.975220123876, 4972.179590367549, 4975.825846095369, 5016.398032236155, 4888.780004899717, 4904.288878112582, 4904.583110435653, 4939.53074457926, 4950.45544990058, 4851.0, 4865.951340486691, 4926.064047830901, 4929.014197160654, 4943.233798761198, 4851.80592776285, 4857.854264372075, 4869.245266983623, 4897.314375987294, 4905.386826646669], "value": 4650.923482250946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2102130927241, 577.9017567013605, 581.0992960910587, 592.1413949772829, 606.2088973889075, 29098.70901290989, 40171.59828401715, 40583.18833623326, 40794.184116317694, 43877.0, 40509.7974510127, 40900.38649420261, 40966.69849665787, 40988.59011409885, 40991.59008409915, 7359.337659610634, 7661.4253930955265, 7779.260970207822, 7802.33680137189, 9947.1544918682, 9794.0, 10126.746831329203, 10132.0, 10137.290389672726, 10138.898611013907, 10150.847737283946, 10220.744481387988, 10230.539625716823, 10233.539490722898, 10235.488225588728, 10161.28870979028, 10170.033846784543, 10180.643677471253, 10190.235732320105, 10196.89803101967, 9951.701448956543, 9983.351082179708, 10027.548760305805, 10029.348092374044, 10039.0, 38790.0, 38811.0, 39119.41320880189, 39150.216995660216, 39206.80396597999, 2898.5797059426263, 2923.1961210667237, 2977.4640564698348, 3010.9247268818453, 3045.4670432674416, 29060.41879162426, 29164.708352916412, 29585.0, 29735.70264297351, 30892.0, 3349.748768842322, 3437.9312413751836, 3441.105312618712, 3455.6198818129988, 3489.4068008438626, 259014.0, 260572.0, 262540.0, 262621.9999999981, 262669.0, 31785.682143178736, 52845.2073218902, 53245.0, 53307.20039199415, 53354.7332263344, 31888.521672174935, 33349.0, 33520.832395838355, 33606.66393336084, 33661.326773464396, 14051.156930584199, 14192.148471091768, 14195.929020354832, 14202.928985355007, 14203.502877399242, 10657.0, 11549.711257218636, 11733.647990560126, 11781.823272650918, 11846.348450835114, 7812.882806757903, 7822.295993360625, 7850.2542258485355, 7894.328982036591, 7903.486273392211, 3112.054965646471, 3112.206387371206, 3145.386649603305, 3162.6204855417036, 3170.1916011416943, 834.7662654456761, 836.7406104107746, 899.5502248875562, 926.5228407370209, 987.5852142100335, 27836.721632783414, 28419.857900710365, 28428.573571396446, 28454.288642784097, 28940.42119157605, 956.6890760502864, 962.7737481691797, 1005.215931573374, 1028.7633844215873, 1050.8318669012922, 14961.476348327975, 15148.621284467976, 15154.318055687521, 15512.612184695472, 15534.922325388301, 373841.0, 376706.0, 376792.0, 378052.0, 378176.0, 49338.0, 49949.50050499449, 49993.25010124851, 50048.74975625172, 50101.49898501041, 1084.6691759013577, 1126.4649291586595, 1162.128403697227, 1177.240679761549, 1183.1067544004393, 25981.870090650184, 28857.711422886343, 29078.854605726836, 29690.55464167996, 29727.70272297249, 48196.0, 48815.267770984174, 48953.0, 48985.0, 49037.754811225714, 347513.0, 350952.0, 351372.0, 352294.0, 353368.0, 25331.6200257, 26038.218853434428, 26105.73894261033, 27540.311492212855, 39026.04869756557, 41730.374044389966, 42404.5759542413, 42517.78741106398, 43235.0, 43435.78282108569, 35979.28041439209, 36037.45943810792, 36207.0, 36890.0, 37091.0, 36461.08847278839, 37061.44407833939, 37656.62343376641, 38338.2332353357, 40273.59726402698, 35525.0, 35852.28295434025, 36837.079073023386, 37203.0, 37535.62464375321, 31394.529082064244, 33377.833110835265, 33499.665003349655, 33947.32105357928, 34112.82943585266, 25626.0, 25843.870780645975, 26073.0, 26151.476970460102, 26171.345716357242], "value": 17275.29231381983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.2191763737495, 362.2899117729249, 374.9343864823656, 376.84172647488055, 388.5240580289146, 12439.25364478132, 17280.913595432023, 17580.472585822416, 18636.72044919324, 18798.436046918614, 16499.752503712454, 17004.0, 18079.638407231847, 18251.45245642633, 18255.908720456413, 4806.303086052529, 5160.045391602547, 5201.895962080756, 5206.921896171541, 5207.270982062514, 3762.868299609514, 5149.356330458692, 5165.560927321182, 5786.739596718157, 6085.569891075594, 6070.028795392738, 6105.54208434367, 6110.938890611082, 6111.449969502743, 6114.480269177126, 5966.701664916758, 6040.516758659319, 6061.121137435091, 6096.207493025922, 6104.420080092428, 5157.381114266312, 5344.759485823109, 5350.464953504657, 5351.277577527023, 5359.08895487768, 21440.571188576298, 21813.0, 21841.890790546106, 21990.89004554967, 22003.889980549993, 2095.7799431059825, 2140.411386868608, 2275.7951784339325, 2371.0515793682493, 2498.375406148463, 13435.798463023062, 13443.3950472228, 13675.452981880713, 13764.0, 13913.652158696113, 1741.3469948769211, 1748.117200813581, 1753.2636292756945, 1818.0727828807271, 1863.0684657671165, 69856.6507167466, 71981.0, 72546.63726681385, 72750.63624681842, 74665.25334746638, 9514.19129374011, 9718.562664679965, 9889.307748457682, 10126.797464050678, 10154.644587439552, 13622.795658065137, 13664.52174173919, 13714.51999180024, 13739.725205495834, 13837.238951857744, 7799.259070388304, 7811.804704882424, 7855.921440785519, 7996.9200307997335, 8032.558209298545, 7550.207228241065, 7629.809254768564, 7880.84238315242, 7886.3296619786815, 7902.0, 6184.536159787944, 6282.937170628235, 6319.8104056878365, 6382.712777925005, 6423.229212494531, 1725.4909801608555, 1806.1480802200774, 1813.8730288879651, 1824.379710898301, 1825.3155066849931, 893.3478560650761, 898.9865152022725, 900.5767289373983, 909.2544113826731, 976.4531862157214, 17620.823791762174, 19206.327778527684, 19256.903715481614, 19380.224791008484, 19568.706469402685, 864.0711235421946, 875.7898104455012, 876.2683159561838, 886.1404437695554, 887.8135591525852, 8999.235065019546, 10780.801039402375, 10836.987303594015, 10837.85034866875, 10876.94561527203, 377924.0, 383482.0, 383875.0, 387829.0, 388061.0, 76277.61861190769, 77836.61081694555, 80596.0, 81092.59453702693, 83224.0, 903.2051794420868, 909.0909090909091, 937.9390339628039, 944.2587568758491, 948.8481842905102, 16547.503574892773, 17007.0, 17333.653326933138, 17386.21762020687, 17391.304347825946, 36009.45985810267, 37134.62865371312, 39285.0, 40434.595654043085, 41101.0, 50558.0, 50987.49012509827, 54087.72956135194, 54500.45499544954, 54933.0, 7526.623668816428, 7595.354394876497, 7697.807554811175, 7714.807129821799, 7894.250046245597, 9559.617615295589, 11854.407279636156, 11991.280523168289, 11992.520299187934, 12091.939540302243, 10130.89869101329, 10215.846762298721, 10221.795564088825, 10550.155987521133, 10572.048515633629, 4907.803687852446, 6373.98016317387, 10133.746656333651, 10507.422091785025, 10516.474176291307, 10010.249231307535, 10039.799204015733, 10084.949575252076, 10115.342502737298, 10361.4301213434, 6743.1908171019795, 7009.474289428415, 7048.295170482911, 7282.67227974753, 8088.676452941816, 8441.409101362846, 10051.195904327782, 10190.541425636013, 10450.68647940563, 10494.317869338469], "value": 8596.826301202807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.9684257893546, 1360.7550640884642, 1422.1324991755027, 1467.9045862018975, 1629.8696104311657, 6726.831829204272, 7532.133804612471, 7766.456348055638, 7784.143744188134, 7987.880181797278, 7784.416168787336, 7825.2174782521715, 7829.334506566935, 7843.254890785381, 7846.450748447611, 2108.768035516092, 2132.488202831325, 2134.231676596424, 2136.9038393272263, 2137.5617998310386, 2062.3915944796245, 2110.2719561751246, 2114.5136618577735, 2131.7548481924546, 2133.1680644548637, 2095.4866057815857, 2108.061912448961, 2115.2279418012467, 2117.04732870209, 2145.7961493658077, 2069.6998935154393, 2082.4585607741947, 2083.2916808285254, 2083.427057559183, 2085.447356450542, 2010.2361102780849, 2075.84790441305, 2076.5431605046865, 2077.7714451410334, 2079.365793433002, 7688.730894418669, 7803.3367163791145, 7898.328642065431, 7901.762947111539, 7915.604219788987, 4455.576720211575, 4616.561426664462, 4623.352730617717, 4630.652701047435, 4638.489766125724, 2694.2725464124774, 2817.647794025747, 2842.9857850710823, 2853.9857300713365, 2858.428314337141, 937.0863408177041, 943.8253923024263, 950.7908260182749, 952.3714348529937, 960.2893858544696, 10530.789384212272, 10612.097971672418, 10620.203484738598, 10625.149988000941, 10626.946865265701, 3928.52857657083, 4076.103257283393, 4077.9796101019897, 4082.714210005271, 4278.529361770203, 8371.958140209383, 8410.579471026547, 8423.70517031901, 8444.788880278042, 8456.11210822867, 4551.249043907785, 4556.316552517149, 4556.635469162459, 4558.247889098328, 4560.156371071363, 3671.6695497405362, 4046.251443482965, 4184.0, 4191.538930717618, 4193.51774545925, 3287.6054873414864, 3298.125996610852, 3415.0, 3425.7773244739014, 3428.9828550857087, 953.2040745977187, 964.7009427077628, 984.4880662055691, 984.9310548261697, 996.1333639733479, 704.989425158623, 807.1484583764185, 815.388458656008, 833.829065041665, 838.9496630202085, 5063.493650634907, 5170.896582068338, 5273.630845840754, 5282.022825777167, 5367.355917289872, 348.7157966257492, 362.9074585980558, 363.2335771522086, 369.60636921678326, 372.13107394234225, 3531.6644918732677, 3625.3293140768515, 3674.81625918703, 3695.8336874840697, 3751.0809851586537, 9350.719478415658, 9855.063768941938, 9878.901210987942, 9891.554880030415, 9907.900920990842, 9517.095875891779, 9608.471534065553, 9807.06832850878, 9873.950630246803, 9888.20894328452, 7417.517861338995, 7472.551646901204, 7473.663685134182, 7477.70089196426, 7485.176630570633, 5051.823186188612, 5085.3134826797905, 5164.7417629119145, 5170.922436163385, 5375.489328513785, 8833.779155521164, 8869.290456763572, 8937.374383793072, 9014.774630634287, 9096.863547046933, 9021.278297736035, 9180.403273787182, 9189.816203675755, 9298.163165315154, 9358.766030849283, 5853.9121913172185, 6079.3008803988105, 6224.595401298901, 6271.153394291712, 6419.871602567829, 6862.759803406857, 7032.085828842218, 7045.11936007999, 7178.210396856446, 7186.712531498891, 6664.7000884959325, 6742.797716068526, 6785.423239024541, 6848.486363522856, 6930.44556435494, 6799.660016999229, 6821.386075253251, 6822.420094291842, 6832.590044597141, 6841.897371539331, 6120.265568131853, 6200.627962322275, 6205.379462053758, 6209.379062093754, 6212.4408803207925, 4431.778411079497, 4496.505384407647, 4551.977240113911, 4588.220002599499, 4636.907261854812, 4490.753008584559, 4527.705699129678, 4618.237990731492, 4622.2835460503675, 4719.05618876233], "value": 3958.9302611275457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.69477049098447, 291.0830882719433, 302.73964390624064, 305.8470764617691, 308.0988109778896, 4804.759762011903, 4911.312416261726, 4931.284963680264, 4942.258661200822, 4945.233488809231, 4825.083234185511, 4845.927311090337, 4894.3147959285725, 4908.656394052417, 4913.53321434464, 3600.8657272959067, 3731.8507259709713, 3746.6440688134585, 3754.7609288934586, 3763.9247215055684, 3733.6932073774096, 3752.5496940367193, 3830.253100645375, 3867.9806600967095, 3881.6700580450697, 3794.6964242860504, 3801.752886062411, 3802.2965751335955, 3831.63599458051, 3853.2293541291715, 3565.144365352297, 3739.6447337502896, 3804.7063998240733, 3838.750481218726, 3849.268638958617, 3296.934061318784, 3300.6864347886913, 3310.4372256716415, 3318.4026875162463, 3325.7505687073567, 4677.368555245032, 4699.929501057487, 4701.177293973541, 4708.764561771898, 4723.362346083303, 4143.274926887812, 4265.0403659176745, 4276.722013069171, 4288.31386978082, 4293.806778694966, 5047.949520504784, 5051.131081499831, 5058.949410505885, 5060.84817455477, 5065.670731402447, 3591.2278860044953, 3613.9819300903328, 3625.456181572759, 3639.4358874374516, 3642.653947874948, 5021.949780502185, 5205.011047900886, 5242.16125419931, 5327.38735045467, 5373.623846330758, 3655.8720444784835, 3678.4850120983083, 3681.116532032293, 3681.963180368162, 3694.946940122052, 3757.6618104370737, 3760.7367484275837, 3767.5102236709054, 3770.547534295847, 3785.690728655518, 4267.487901451784, 4302.763348015889, 4315.805788739514, 4323.351497275434, 4333.58830911063, 4923.409190897044, 4983.654413308386, 5032.949670503322, 5049.31834202378, 5061.898762024739, 1270.9872901271053, 1288.5940928607458, 1291.876067820983, 1300.1159211735921, 1311.6196303072193, 777.906651201848, 817.7015389382951, 821.199330652609, 821.6631181215673, 828.1470085811624, 4273.995611031405, 4326.372675961968, 4406.889827754332, 4472.217361961643, 4484.529124441952, 5200.479952004845, 5207.739613019334, 5233.371995360581, 5237.3453318335205, 5241.532370936144, 4441.222786012435, 4443.688941774045, 4449.110177964355, 4507.977460112678, 4513.435820522434, 2651.8331933949385, 2723.128598848389, 2769.7645700115313, 2774.84843789829, 2789.2050765531726, 4867.683600565952, 4899.730514821719, 4901.627544287605, 4903.975480122648, 4935.555799977948, 5098.745062746848, 5290.338707661543, 5332.06688829461, 5380.381256155514, 5400.513953744182, 4848.951510484921, 4856.757162141949, 4862.51374862518, 4868.271763523969, 4880.463149053601, 5155.716435596079, 5201.453847346125, 5236.790528378974, 5240.318758561362, 5251.291075704884, 4938.135826230324, 5089.592832573459, 5098.286239926488, 5104.259882316969, 5105.489451055013, 4868.732219727949, 4875.975620122019, 4885.874644529641, 4890.902181956412, 4904.362432883845, 3654.6893514051603, 3670.541182352206, 3697.9815100924325, 3730.0, 3741.0, 5042.949570504248, 5302.681839089667, 5322.654027488201, 5335.119705248746, 5352.197170424468, 5090.770915308746, 5094.6688465249645, 5102.188723003281, 5103.642745007814, 5137.280780690631, 5079.492050794891, 5091.719955402488, 5097.413797413345, 5099.87250318745, 5115.104856650146, 4810.470848206624, 4961.0, 4962.280469331999, 4977.701337919736, 4986.276989836526, 4828.696252012008, 4976.377952755905, 5060.886604946906, 5086.898262034812, 5087.872803179802, 4825.662203645711, 4840.201366774443, 4842.7336496493035, 4870.31815545831, 4891.168501354707], "value": 3809.887652394181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.6105067484847, 671.8286836856604, 672.8620632770283, 727.6434547071937, 767.4282659418732, 12692.555760548383, 13832.585022449317, 13836.23900685462, 13845.58463246103, 13919.721605567882, 13694.863051369482, 14231.217283049427, 14520.0, 14835.332410041547, 15002.549923502285, 639.6993413095837, 780.3172224303748, 798.8362385710944, 798.9400794940374, 799.2886331165267, 757.8143354878035, 791.513219370089, 794.66226853587, 795.1055063054064, 795.8806179073157, 832.2010869565195, 834.3700506117873, 834.8121672623672, 835.1106072033265, 835.3192148399036, 653.9313372095957, 823.27551754456, 823.6170180865867, 823.9299659528947, 824.0523398092182, 578.2627150383295, 595.0360416125903, 595.2767387624015, 597.2027343496437, 598.1118039711025, 13051.738965220737, 13063.86936130636, 13066.477340906353, 13076.08467407282, 13124.934375328157, 12150.45322960469, 12197.69084474349, 12372.628821135291, 12474.81287780684, 12840.229586224856, 11549.13381496391, 11566.42167891602, 11632.476538555786, 11859.169858109935, 12007.3395963222, 4017.5580686124504, 4074.6740260779065, 4098.815553300109, 4157.646600039, 4204.3693445983345, 58782.41217587812, 59997.40002599962, 60002.699986499785, 60710.696446517926, 60721.6963915182, 9708.75728106803, 10062.295639305325, 10178.389296642225, 10250.794984100425, 10337.793244135226, 18990.0, 19359.709604355947, 19369.709454358195, 19375.3218637347, 19376.321828736207, 6633.966830165915, 6735.8989615155815, 6782.898256526156, 6797.5581587196675, 7049.154101507852, 3656.0859785053735, 3668.614795446493, 3734.5705243896755, 3760.7555508891833, 3767.962320376816, 2778.263760103574, 2896.9130926072253, 2903.419316136781, 2903.564465330175, 2906.433245517104, 533.2481201505858, 543.5189856976605, 550.4770468055283, 551.9889602207934, 562.5780664501624, 433.3521385528655, 488.64329039801146, 520.9088409528317, 522.516672078326, 595.9642421454727, 7661.0, 7817.788242822372, 7843.705643629689, 7865.213478652204, 8127.959360203161, 458.33999041380304, 479.05386860949346, 505.9595232381401, 534.3801190618864, 564.1650357470966, 3762.6237376262156, 3799.549896416568, 3815.1415931415763, 3844.2503711776494, 4020.1758639478835, 55696.82273829479, 56731.716341418854, 75511.62244188854, 99451.0, 99782.0, 78983.0, 79110.60444697854, 79769.0, 81833.0, 81934.59032704799, 45872.082558348644, 71069.2893071073, 71600.0, 71633.6418317905, 73401.63299183683, 7094.042637975775, 7303.926960730537, 7443.55338679681, 7462.850742985219, 7646.4265180112825, 31514.684853151175, 34919.82540087283, 40436.79781601073, 40723.38914916338, 41913.0, 56528.434715652314, 60965.0, 62198.378016219256, 64982.0, 65471.34528654652, 9699.757506062122, 10395.16838652921, 10606.628767993083, 10667.626633067805, 10877.347359158475, 10737.731556711145, 10751.569937202737, 11089.27919685218, 11100.444977751242, 11350.60272890478, 9860.901390985999, 10072.647457338959, 10088.142507886912, 10183.287169898036, 10470.685879423629, 9269.212116970133, 9517.619295228113, 9532.428054316762, 9544.42733435996, 9619.90380096218, 9294.628214871329, 9309.301802364986, 9337.20633746112, 9597.90402095998, 10206.59173633076, 9070.138336857988, 9094.454332740057, 9128.589213485277, 9249.12133347331, 9273.768155796159, 9167.0, 9510.493671074388, 9599.752496245263, 9603.759906002406, 9651.227901767983], "value": 6307.660634980969, "unit": "score"}], "name": "dromaeo_css", "value": 6352.608299772774, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 114.0, 112.0, 114.0, 115.0, 112.0, 113.0, 116.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 123.0, 127.0, 181.0, 123.0, 124.0, 155.0, 123.0, 162.0, 122.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 160.0, 161.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 114.0, 75.0, 75.0, 75.0, 75.0, 104.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 119.0, 85.0, 85.0, 87.0, 132.0, 85.0, 85.0, 128.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 62.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 61.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 79.0, 80.0, 79.0, 79.0, 78.0, 78.0, 83.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 138.0, 137.0, 128.0, 129.0, 135.0, 128.0, 208.0, 132.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 161.0, 164.0, 161.0, 165.0, 161.0, 163.0, 161.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 68.0, 65.0, 65.0, 66.0, 69.0, 66.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1526.6000000000004, "alertThreshold": 2.0}]} 07:02:45 INFO - Return code: 0 07:02:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:02:45 INFO - # TBPL SUCCESS # 07:02:45 INFO - Running post-action listener: _resource_record_post_action 07:02:45 INFO - [mozharness: 2016-07-24 14:02:45.995020Z] Finished run-tests step (success) 07:02:45 INFO - Running post-run listener: _resource_record_post_run 07:02:46 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536784896; Read time: 20; Write time: 510184 07:02:46 INFO - TinderboxPrint: CPU usage
13.0% 07:02:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 07:02:46 INFO - TinderboxPrint: I/O write bytes / time
536,784,896 / 510,184 07:02:46 INFO - TinderboxPrint: CPU idle
8,326.6 (87.0%) 07:02:46 INFO - TinderboxPrint: CPU user
1,199.2 (12.5%) 07:02:46 INFO - TinderboxPrint: Swap in / out
0 / 0 07:02:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246599680; Read time: 0; Write time: 307604 07:02:46 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283471872; Read time: 20; Write time: 201000 07:02:46 INFO - Running post-run listener: _upload_blobber_files 07:02:46 INFO - Blob upload gear active. 07:02:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:02:46 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 07:02:46 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'] 07:02:46 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 07:02:47 INFO - (blobuploader) - INFO - Open directory for files ... 07:02:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:02:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:02:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:47 INFO - (blobuploader) - INFO - Done attempting. 07:02:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:02:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:02:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:56 INFO - (blobuploader) - INFO - Done attempting. 07:02:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:57 INFO - (blobuploader) - INFO - Done attempting. 07:02:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:02:57 INFO - Return code: 0 07:02:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:02:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:02:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d629355dd41eaaa3af44bd237f969074df09a983fd33519cb93c54f0414939674f8ff4254c25414425517c54f8652e7950cd3a7be94a3d0510f6e678ebd1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2ab487687e845565d12bcac95c5aee3ef5ed437f31c212b7bcd595d5c626c03d50d315f7734ba08e72b3eb150e05bcd1f80da44064cfb9d6ed5018ae522571d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149f9b9f630c199eec6d0f7eb425a38dfac57d54ce2870bd8b0f5ae22e15cc4b17070a02758d1c8ade590b84668509c9acf4126fed3f88259caeeb0cf2119eed"} 07:02:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:02:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:02:57 INFO - Contents: 07:02:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d629355dd41eaaa3af44bd237f969074df09a983fd33519cb93c54f0414939674f8ff4254c25414425517c54f8652e7950cd3a7be94a3d0510f6e678ebd1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2ab487687e845565d12bcac95c5aee3ef5ed437f31c212b7bcd595d5c626c03d50d315f7734ba08e72b3eb150e05bcd1f80da44064cfb9d6ed5018ae522571d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149f9b9f630c199eec6d0f7eb425a38dfac57d54ce2870bd8b0f5ae22e15cc4b17070a02758d1c8ade590b84668509c9acf4126fed3f88259caeeb0cf2119eed"} 07:02:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:02:57 INFO - Copying logs to upload dir... 07:02:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:02:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.617170 ========= master_lag: 0.84 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-24 07:02:57.854593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 07:02:57.859943) ========= 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=232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d629355dd41eaaa3af44bd237f969074df09a983fd33519cb93c54f0414939674f8ff4254c25414425517c54f8652e7950cd3a7be94a3d0510f6e678ebd1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2ab487687e845565d12bcac95c5aee3ef5ed437f31c212b7bcd595d5c626c03d50d315f7734ba08e72b3eb150e05bcd1f80da44064cfb9d6ed5018ae522571d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149f9b9f630c199eec6d0f7eb425a38dfac57d54ce2870bd8b0f5ae22e15cc4b17070a02758d1c8ade590b84668509c9acf4126fed3f88259caeeb0cf2119eed"} build_url:https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010445 build_url: 'https://queue.taskcluster.net/v1/task/CntEh4T8QZiEU139PrudEg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d629355dd41eaaa3af44bd237f969074df09a983fd33519cb93c54f0414939674f8ff4254c25414425517c54f8652e7950cd3a7be94a3d0510f6e678ebd1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2ab487687e845565d12bcac95c5aee3ef5ed437f31c212b7bcd595d5c626c03d50d315f7734ba08e72b3eb150e05bcd1f80da44064cfb9d6ed5018ae522571d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149f9b9f630c199eec6d0f7eb425a38dfac57d54ce2870bd8b0f5ae22e15cc4b17070a02758d1c8ade590b84668509c9acf4126fed3f88259caeeb0cf2119eed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 07:02:57.888841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 07:02:57.889270) ========= 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=232498196343f89f466a4a9a000001c8-1469367649.674134-1012625714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 07:02:57.941883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 07:02:57.942489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 07:02:57.943221) ========= ========= Total master_lag: 0.98 =========