builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1472829222.2 results: success (0) buildid: 20160902053001 builduid: 1a1920aab797485e9a7d8161007660af revision: 884f60cd86d31b32ec4883246ace726bc93e445b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.199054) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.199501) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.199792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.217446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.217754) ========= 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=920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 08:13:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-09-02 08:13:42 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093369 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.324475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.324765) ========= 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=920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019452 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.396158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:42.396502) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 884f60cd86d31b32ec4883246ace726bc93e445b --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 884f60cd86d31b32ec4883246ace726bc93e445b --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=920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 08:13:43,001 truncating revision to first 12 chars 2016-09-02 08:13:43,001 Setting DEBUG logging. 2016-09-02 08:13:43,001 attempt 1/10 2016-09-02 08:13:43,001 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/884f60cd86d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 08:13:43,306 unpacking tar archive at: fx-team-884f60cd86d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:43.140044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:43.140369) ========= script_repo_revision: 884f60cd86d31b32ec4883246ace726bc93e445b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:43.140787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:43.141067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 08:13:43.149751) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-02 08:13:43.150119) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:13:43 INFO - MultiFileLogger online at 20160902 08:13:43 in /builds/slave/test 08:13:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:13:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:43 INFO - {'append_to_log': False, 08:13:43 INFO - 'base_work_dir': '/builds/slave/test', 08:13:43 INFO - 'blob_upload_branch': 'Fx-Team', 08:13:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:43 INFO - 'branch': 'Fx-Team', 08:13:43 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:43 INFO - 'config_files': ('talos/linux_config.py',), 08:13:43 INFO - 'default_actions': ('clobber', 08:13:43 INFO - 'read-buildbot-config', 08:13:43 INFO - 'download-and-extract', 08:13:43 INFO - 'populate-webroot', 08:13:43 INFO - 'create-virtualenv', 08:13:43 INFO - 'install', 08:13:43 INFO - 'run-tests'), 08:13:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:43 INFO - 'download_minidump_stackwalk': True, 08:13:43 INFO - 'download_symbols': 'ondemand', 08:13:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:43 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:43 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:43 INFO - 'installer_path': 'installer.exe', 08:13:43 INFO - 'log_level': 'info', 08:13:43 INFO - 'log_name': 'talos', 08:13:43 INFO - 'log_to_console': True, 08:13:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:13:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:13:43 INFO - 'opt_config_files': (), 08:13:43 INFO - 'pip_index': False, 08:13:43 INFO - 'sps_profile': False, 08:13:43 INFO - 'sps_profile_interval': 0, 08:13:43 INFO - 'suite': 'dromaeojs', 08:13:43 INFO - 'system_bits': '32', 08:13:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:43 INFO - 'title': 'talos-linux64-ix-053', 08:13:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:43 INFO - 'use_talos_json': True, 08:13:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:43 INFO - 'work_dir': 'build'} 08:13:43 INFO - [mozharness: 2016-09-02 15:13:43.844395Z] Running clobber step. 08:13:43 INFO - Running pre-action listener: _resource_record_pre_action 08:13:43 INFO - Running main action method: clobber 08:13:43 INFO - rmtree: /builds/slave/test/build 08:13:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:44 INFO - Running post-action listener: _resource_record_post_action 08:13:44 INFO - [mozharness: 2016-09-02 15:13:44.300623Z] Finished clobber step (success) 08:13:44 INFO - [mozharness: 2016-09-02 15:13:44.300724Z] Running read-buildbot-config step. 08:13:44 INFO - Running pre-action listener: _resource_record_pre_action 08:13:44 INFO - Running main action method: read_buildbot_config 08:13:44 INFO - Using buildbot properties: 08:13:44 INFO - { 08:13:44 INFO - "project": "", 08:13:44 INFO - "product": "firefox", 08:13:44 INFO - "script_repo_revision": "production", 08:13:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:13:44 INFO - "repository": "", 08:13:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:13:44 INFO - "buildid": "20160902053001", 08:13:44 INFO - "pgo_build": "True", 08:13:44 INFO - "basedir": "/builds/slave/test", 08:13:44 INFO - "buildnumber": 1523, 08:13:44 INFO - "slavename": "talos-linux64-ix-053", 08:13:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:13:44 INFO - "platform": "ubuntu64_hw", 08:13:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:13:44 INFO - "branch": "fx-team", 08:13:44 INFO - "repo_path": "integration/fx-team", 08:13:44 INFO - "revision": "884f60cd86d31b32ec4883246ace726bc93e445b", 08:13:44 INFO - "stage_platform": "linux64-pgo", 08:13:44 INFO - "builduid": "1a1920aab797485e9a7d8161007660af", 08:13:44 INFO - "slavebuilddir": "test" 08:13:44 INFO - } 08:13:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:13:44 INFO - Running post-action listener: _resource_record_post_action 08:13:44 INFO - [mozharness: 2016-09-02 15:13:44.303660Z] Finished read-buildbot-config step (success) 08:13:44 INFO - [mozharness: 2016-09-02 15:13:44.303751Z] Running download-and-extract step. 08:13:44 INFO - Running pre-action listener: _resource_record_pre_action 08:13:44 INFO - Running main action method: download_and_extract 08:13:44 INFO - mkdir: /builds/slave/test/build/tests 08:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:44 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:13:44 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:13:44 INFO - Downloaded 1361 bytes. 08:13:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:13:44 INFO - Using the following test package requirements: 08:13:44 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:13:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:13:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'jsshell-linux-x86_64.zip'], 08:13:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:13:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:13:44 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:13:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:13:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:13:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:44 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:44 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:46 INFO - Downloaded 21905047 bytes. 08:13:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:13:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:50 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:50 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:51 INFO - Downloaded 21905047 bytes. 08:13:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:56 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:56 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:13:57 INFO - Downloaded 14413998 bytes. 08:13:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:57 INFO - trying https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:57 INFO - Downloading https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:00 INFO - Downloaded 59731025 bytes. 08:14:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:14:00 INFO - mkdir: /builds/slave/test/properties 08:14:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:00 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:00 INFO - Contents: 08:14:00 INFO - build_url:https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:14:00 INFO - Running post-action listener: _resource_record_post_action 08:14:00 INFO - Running post-action listener: set_extra_try_arguments 08:14:00 INFO - [mozharness: 2016-09-02 15:14:00.875519Z] Finished download-and-extract step (success) 08:14:00 INFO - [mozharness: 2016-09-02 15:14:00.875744Z] Running populate-webroot step. 08:14:00 INFO - Running pre-action listener: _resource_record_pre_action 08:14:00 INFO - Running main action method: populate_webroot 08:14:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:00 INFO - '--tppagecycles', 08:14:00 INFO - '7'], 08:14:00 INFO - 'tests': ['tsvgm']}}, 08:14:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['damp', 'tps']}, 08:14:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'tests': ['damp', 'tps']}, 08:14:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['dromaeo_dom']}, 08:14:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['basic_compositor_video']}, 08:14:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['a11yr', 08:14:00 INFO - 'ts_paint', 08:14:00 INFO - 'tpaint', 08:14:00 INFO - 'sessionrestore', 08:14:00 INFO - 'sessionrestore_no_auto_restore', 08:14:00 INFO - 'tabpaint']}, 08:14:00 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:00 INFO - 'ts_paint', 08:14:00 INFO - 'tpaint', 08:14:00 INFO - 'sessionrestore', 08:14:00 INFO - 'sessionrestore_no_auto_restore', 08:14:00 INFO - 'tabpaint']}, 08:14:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:00 INFO - 'ts_paint', 08:14:00 INFO - 'tpaint', 08:14:00 INFO - 'sessionrestore', 08:14:00 INFO - 'sessionrestore_no_auto_restore', 08:14:00 INFO - 'tabpaint']}, 08:14:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:00 INFO - 'ts_paint', 08:14:00 INFO - 'tpaint', 08:14:00 INFO - 'sessionrestore', 08:14:00 INFO - 'sessionrestore_no_auto_restore', 08:14:00 INFO - 'tabpaint']}, 08:14:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['a11yr', 08:14:00 INFO - 'ts_paint', 08:14:00 INFO - 'tpaint', 08:14:00 INFO - 'sessionrestore', 08:14:00 INFO - 'sessionrestore_no_auto_restore', 08:14:00 INFO - 'tabpaint']}, 08:14:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['a11yr', 08:14:00 INFO - 'ts_paint', 08:14:00 INFO - 'tpaint', 08:14:00 INFO - 'sessionrestore', 08:14:00 INFO - 'sessionrestore_no_auto_restore', 08:14:00 INFO - 'tabpaint']}, 08:14:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['tsvgx', 08:14:00 INFO - 'tsvgr_opacity', 08:14:00 INFO - 'tart', 08:14:00 INFO - 'tscrollx', 08:14:00 INFO - 'cart']}, 08:14:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:00 INFO - 'tsvgr_opacity', 08:14:00 INFO - 'tart', 08:14:00 INFO - 'tscrollx', 08:14:00 INFO - 'cart']}, 08:14:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'talos_options': ['--disable-e10s'], 08:14:00 INFO - 'tests': ['tp5o']}, 08:14:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'tests': ['tp5o']}, 08:14:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'talos_options': ['--disable-e10s', 08:14:00 INFO - '--xperf_path', 08:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:00 INFO - 'tests': ['tp5n']}, 08:14:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:00 INFO - 'talos_options': ['--xperf_path', 08:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:00 INFO - 'tests': ['tp5n']}}, 08:14:00 INFO - 'talos.zip': {'path': '', 08:14:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:00 INFO - Running post-action listener: _resource_record_post_action 08:14:00 INFO - [mozharness: 2016-09-02 15:14:00.900698Z] Finished populate-webroot step (success) 08:14:00 INFO - [mozharness: 2016-09-02 15:14:00.900787Z] Running create-virtualenv step. 08:14:00 INFO - Running pre-action listener: _resource_record_pre_action 08:14:00 INFO - Running main action method: create_virtualenv 08:14:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:00 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 08:14:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:00 INFO - Using real prefix '/usr' 08:14:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:03 INFO - Installing pip.................done. 08:14:03 INFO - Return code: 0 08:14:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:03 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:03 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 08:14:03 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 08:14:03 INFO - Using env: {'DISPLAY': ':0', 08:14:03 INFO - 'HOME': '/home/cltbld', 08:14:03 INFO - 'LANG': 'en_US.UTF-8', 08:14:03 INFO - 'LANGUAGE': 'en_US:en', 08:14:03 INFO - 'LOGNAME': 'cltbld', 08:14:03 INFO - 'MAIL': '/var/mail/cltbld', 08:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:03 INFO - 'MOZ_NO_REMOTE': '1', 08:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:03 INFO - 'NO_EM_RESTART': '1', 08:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:03 INFO - 'PWD': '/builds/slave/test', 08:14:03 INFO - 'SHELL': '/bin/bash', 08:14:03 INFO - 'SHLVL': '1', 08:14:03 INFO - 'TERM': 'linux', 08:14:03 INFO - 'TMOUT': '86400', 08:14:03 INFO - 'USER': 'cltbld', 08:14:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:03 INFO - '_': '/tools/buildbot/bin/python'} 08:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:03 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 08:14:03 INFO - Cleaning up... 08:14:03 INFO - Return code: 0 08:14:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:03 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:03 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 08:14:03 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 08:14:03 INFO - Using env: {'DISPLAY': ':0', 08:14:03 INFO - 'HOME': '/home/cltbld', 08:14:03 INFO - 'LANG': 'en_US.UTF-8', 08:14:03 INFO - 'LANGUAGE': 'en_US:en', 08:14:03 INFO - 'LOGNAME': 'cltbld', 08:14:03 INFO - 'MAIL': '/var/mail/cltbld', 08:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:03 INFO - 'MOZ_NO_REMOTE': '1', 08:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:03 INFO - 'NO_EM_RESTART': '1', 08:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:03 INFO - 'PWD': '/builds/slave/test', 08:14:03 INFO - 'SHELL': '/bin/bash', 08:14:03 INFO - 'SHLVL': '1', 08:14:03 INFO - 'TERM': 'linux', 08:14:03 INFO - 'TMOUT': '86400', 08:14:03 INFO - 'USER': 'cltbld', 08:14:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:03 INFO - '_': '/tools/buildbot/bin/python'} 08:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:03 INFO - Downloading/unpacking psutil>=3.1.1 08:14:03 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 08:14:03 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 08:14:03 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 08:14:03 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 08:14:03 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 08:14:03 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 08:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:05 INFO - Installing collected packages: psutil 08:14:05 INFO - Running setup.py install for psutil 08:14:05 INFO - building 'psutil._psutil_linux' extension 08:14:05 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 08:14:06 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 08:14:06 INFO - building 'psutil._psutil_posix' extension 08:14:06 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 08:14:06 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 08:14:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:06 INFO - Successfully installed psutil 08:14:06 INFO - Cleaning up... 08:14:06 INFO - Return code: 0 08:14:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:06 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:06 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 08:14:06 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 08:14:06 INFO - Using env: {'DISPLAY': ':0', 08:14:06 INFO - 'HOME': '/home/cltbld', 08:14:06 INFO - 'LANG': 'en_US.UTF-8', 08:14:06 INFO - 'LANGUAGE': 'en_US:en', 08:14:06 INFO - 'LOGNAME': 'cltbld', 08:14:06 INFO - 'MAIL': '/var/mail/cltbld', 08:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:06 INFO - 'MOZ_NO_REMOTE': '1', 08:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:06 INFO - 'NO_EM_RESTART': '1', 08:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:06 INFO - 'PWD': '/builds/slave/test', 08:14:06 INFO - 'SHELL': '/bin/bash', 08:14:06 INFO - 'SHLVL': '1', 08:14:06 INFO - 'TERM': 'linux', 08:14:06 INFO - 'TMOUT': '86400', 08:14:06 INFO - 'USER': 'cltbld', 08:14:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:06 INFO - '_': '/tools/buildbot/bin/python'} 08:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:06 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 08:14:06 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 08:14:06 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 08:14:06 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 08:14:06 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 08:14:06 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 08:14:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:08 INFO - Installing collected packages: mozsystemmonitor 08:14:08 INFO - Running setup.py install for mozsystemmonitor 08:14:08 INFO - Successfully installed mozsystemmonitor 08:14:08 INFO - Cleaning up... 08:14:08 INFO - Return code: 0 08:14:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:08 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:08 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 08:14:08 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 08:14:08 INFO - Using env: {'DISPLAY': ':0', 08:14:08 INFO - 'HOME': '/home/cltbld', 08:14:08 INFO - 'LANG': 'en_US.UTF-8', 08:14:08 INFO - 'LANGUAGE': 'en_US:en', 08:14:08 INFO - 'LOGNAME': 'cltbld', 08:14:08 INFO - 'MAIL': '/var/mail/cltbld', 08:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:08 INFO - 'MOZ_NO_REMOTE': '1', 08:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:08 INFO - 'NO_EM_RESTART': '1', 08:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:08 INFO - 'PWD': '/builds/slave/test', 08:14:08 INFO - 'SHELL': '/bin/bash', 08:14:08 INFO - 'SHLVL': '1', 08:14:08 INFO - 'TERM': 'linux', 08:14:08 INFO - 'TMOUT': '86400', 08:14:08 INFO - 'USER': 'cltbld', 08:14:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:08 INFO - '_': '/tools/buildbot/bin/python'} 08:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:08 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 08:14:08 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 08:14:08 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 08:14:08 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 08:14:08 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 08:14:08 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 08:14:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:10 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 08:14:10 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 08:14:10 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 08:14:10 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 08:14:10 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 08:14:10 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 08:14:11 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:11 INFO - warning: no files found matching '*.txt' 08:14:11 INFO - no previously-included directories found matching 'build' 08:14:11 INFO - no previously-included directories found matching 'dist' 08:14:11 INFO - no previously-included directories found matching '.git*' 08:14:11 INFO - Installing collected packages: jsonschema, functools32 08:14:11 INFO - Running setup.py install for functools32 08:14:11 INFO - warning: no files found matching '*.txt' 08:14:11 INFO - no previously-included directories found matching 'build' 08:14:11 INFO - no previously-included directories found matching 'dist' 08:14:11 INFO - no previously-included directories found matching '.git*' 08:14:11 INFO - Successfully installed jsonschema functools32 08:14:11 INFO - Cleaning up... 08:14:11 INFO - Return code: 0 08:14:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:14:11 INFO - Using env: {'DISPLAY': ':0', 08:14:11 INFO - 'HOME': '/home/cltbld', 08:14:11 INFO - 'LANG': 'en_US.UTF-8', 08:14:11 INFO - 'LANGUAGE': 'en_US:en', 08:14:11 INFO - 'LOGNAME': 'cltbld', 08:14:11 INFO - 'MAIL': '/var/mail/cltbld', 08:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:11 INFO - 'MOZ_NO_REMOTE': '1', 08:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:11 INFO - 'NO_EM_RESTART': '1', 08:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:11 INFO - 'PWD': '/builds/slave/test', 08:14:11 INFO - 'SHELL': '/bin/bash', 08:14:11 INFO - 'SHLVL': '1', 08:14:11 INFO - 'TERM': 'linux', 08:14:11 INFO - 'TMOUT': '86400', 08:14:11 INFO - 'USER': 'cltbld', 08:14:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:11 INFO - '_': '/tools/buildbot/bin/python'} 08:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:11 INFO - Cleaning up... 08:14:11 INFO - Return code: 0 08:14:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:11 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:11 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 08:14:11 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 08:14:11 INFO - Using env: {'DISPLAY': ':0', 08:14:11 INFO - 'HOME': '/home/cltbld', 08:14:11 INFO - 'LANG': 'en_US.UTF-8', 08:14:11 INFO - 'LANGUAGE': 'en_US:en', 08:14:11 INFO - 'LOGNAME': 'cltbld', 08:14:11 INFO - 'MAIL': '/var/mail/cltbld', 08:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:11 INFO - 'MOZ_NO_REMOTE': '1', 08:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:11 INFO - 'NO_EM_RESTART': '1', 08:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:11 INFO - 'PWD': '/builds/slave/test', 08:14:11 INFO - 'SHELL': '/bin/bash', 08:14:11 INFO - 'SHLVL': '1', 08:14:11 INFO - 'TERM': 'linux', 08:14:11 INFO - 'TMOUT': '86400', 08:14:11 INFO - 'USER': 'cltbld', 08:14:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:11 INFO - '_': '/tools/buildbot/bin/python'} 08:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:11 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 08:14:11 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 08:14:11 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 08:14:11 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 08:14:11 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 08:14:11 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 08:14:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:13 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 08:14:13 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 08:14:13 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 08:14:13 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 08:14:13 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 08:14:13 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 08:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:14 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 08:14:14 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 08:14:14 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 08:14:14 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 08:14:14 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 08:14:14 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 08:14:14 INFO - Downloading docopt-0.6.1.tar.gz 08:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:14 INFO - Running setup.py install for blobuploader 08:14:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:14 INFO - Running setup.py install for requests 08:14:14 INFO - Running setup.py install for docopt 08:14:14 INFO - Successfully installed blobuploader requests docopt 08:14:14 INFO - Cleaning up... 08:14:15 INFO - Return code: 0 08:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:15 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:15 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 08:14:15 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 08:14:15 INFO - Using env: {'DISPLAY': ':0', 08:14:15 INFO - 'HOME': '/home/cltbld', 08:14:15 INFO - 'LANG': 'en_US.UTF-8', 08:14:15 INFO - 'LANGUAGE': 'en_US:en', 08:14:15 INFO - 'LOGNAME': 'cltbld', 08:14:15 INFO - 'MAIL': '/var/mail/cltbld', 08:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:15 INFO - 'MOZ_NO_REMOTE': '1', 08:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:15 INFO - 'NO_EM_RESTART': '1', 08:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:15 INFO - 'PWD': '/builds/slave/test', 08:14:15 INFO - 'SHELL': '/bin/bash', 08:14:15 INFO - 'SHLVL': '1', 08:14:15 INFO - 'TERM': 'linux', 08:14:15 INFO - 'TMOUT': '86400', 08:14:15 INFO - 'USER': 'cltbld', 08:14:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:15 INFO - '_': '/tools/buildbot/bin/python'} 08:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:15 INFO - Running setup.py (path:/tmp/pip-v2KdAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:15 INFO - Running setup.py (path:/tmp/pip-utShSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:15 INFO - Running setup.py (path:/tmp/pip-UAvu8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:15 INFO - Running setup.py (path:/tmp/pip-k5B7Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:15 INFO - Running setup.py (path:/tmp/pip-4LQsRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:15 INFO - Running setup.py (path:/tmp/pip-VV8owu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:15 INFO - Running setup.py (path:/tmp/pip-fUC5sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:15 INFO - Running setup.py (path:/tmp/pip-t8Stv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:15 INFO - Running setup.py (path:/tmp/pip-8h_O_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:15 INFO - Running setup.py (path:/tmp/pip-PscS6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:15 INFO - Running setup.py (path:/tmp/pip-rL3Xle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:16 INFO - Running setup.py (path:/tmp/pip-9DdGSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:16 INFO - Running setup.py (path:/tmp/pip-gr_shw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:16 INFO - Running setup.py (path:/tmp/pip-g7yH8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:16 INFO - Running setup.py (path:/tmp/pip-sx1d4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:16 INFO - Running setup.py (path:/tmp/pip-WsCH2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:16 INFO - Running setup.py (path:/tmp/pip-TvkCfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:16 INFO - Running setup.py install for manifestparser 08:14:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:16 INFO - Running setup.py install for mozcrash 08:14:16 INFO - Running setup.py install for mozdebug 08:14:16 INFO - Running setup.py install for mozdevice 08:14:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:16 INFO - Running setup.py install for mozfile 08:14:16 INFO - Running setup.py install for mozhttpd 08:14:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Running setup.py install for mozinfo 08:14:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Running setup.py install for mozInstall 08:14:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Running setup.py install for mozleak 08:14:17 INFO - Running setup.py install for mozlog 08:14:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Running setup.py install for moznetwork 08:14:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Running setup.py install for mozprocess 08:14:17 INFO - Running setup.py install for mozprofile 08:14:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Running setup.py install for mozrunner 08:14:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:17 INFO - Running setup.py install for mozscreenshot 08:14:18 INFO - Running setup.py install for moztest 08:14:18 INFO - Running setup.py install for mozversion 08:14:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:18 INFO - Cleaning up... 08:14:18 INFO - Return code: 0 08:14:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:18 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 08:14:18 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 08:14:18 INFO - Using env: {'DISPLAY': ':0', 08:14:18 INFO - 'HOME': '/home/cltbld', 08:14:18 INFO - 'LANG': 'en_US.UTF-8', 08:14:18 INFO - 'LANGUAGE': 'en_US:en', 08:14:18 INFO - 'LOGNAME': 'cltbld', 08:14:18 INFO - 'MAIL': '/var/mail/cltbld', 08:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:18 INFO - 'MOZ_NO_REMOTE': '1', 08:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:18 INFO - 'NO_EM_RESTART': '1', 08:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:18 INFO - 'PWD': '/builds/slave/test', 08:14:18 INFO - 'SHELL': '/bin/bash', 08:14:18 INFO - 'SHLVL': '1', 08:14:18 INFO - 'TERM': 'linux', 08:14:18 INFO - 'TMOUT': '86400', 08:14:18 INFO - 'USER': 'cltbld', 08:14:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:18 INFO - '_': '/tools/buildbot/bin/python'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:18 INFO - Running setup.py (path:/tmp/pip-syC2Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:18 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)) 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:18 INFO - Running setup.py (path:/tmp/pip-Q80Q6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:18 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)) 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:18 INFO - Running setup.py (path:/tmp/pip-tzQDCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:18 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)) 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:18 INFO - Running setup.py (path:/tmp/pip-66iP2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:18 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)) 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:18 INFO - Running setup.py (path:/tmp/pip-wZnyPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:18 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)) 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:18 INFO - Running setup.py (path:/tmp/pip-FjLnx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:18 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)) 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:18 INFO - Running setup.py (path:/tmp/pip-B95Zhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:18 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)) 08:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:19 INFO - Running setup.py (path:/tmp/pip-FdpMsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:19 INFO - Running setup.py (path:/tmp/pip-Umlm09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:19 INFO - Running setup.py (path:/tmp/pip-aJWubT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:19 INFO - Running setup.py (path:/tmp/pip-kkhqHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:19 INFO - Running setup.py (path:/tmp/pip-lNuty_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:19 INFO - Running setup.py (path:/tmp/pip-U0ydLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:19 INFO - Running setup.py (path:/tmp/pip-AZEEy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:19 INFO - Running setup.py (path:/tmp/pip-zAk5_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:19 INFO - Running setup.py (path:/tmp/pip-d1Vx4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:19 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)) 08:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:19 INFO - Running setup.py (path:/tmp/pip-FvqNM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:19 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)) 08:14:19 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)) 08:14:19 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)) 08:14:19 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)) 08:14:19 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)) 08:14:19 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)) 08:14:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:19 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 08:14:19 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 08:14:19 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 08:14:19 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 08:14:19 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 08:14:19 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 08:14:21 INFO - Downloading blessings-1.6.tar.gz 08:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:21 INFO - Installing collected packages: blessings 08:14:21 INFO - Running setup.py install for blessings 08:14:21 INFO - Successfully installed blessings 08:14:21 INFO - Cleaning up... 08:14:21 INFO - Return code: 0 08:14:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:22 INFO - Reading from file tmpfile_stdout 08:14:22 INFO - Current package versions: 08:14:22 INFO - argparse == 1.2.1 08:14:22 INFO - blessings == 1.6 08:14:22 INFO - blobuploader == 1.2.4 08:14:22 INFO - docopt == 0.6.1 08:14:22 INFO - functools32 == 3.2.3-2 08:14:22 INFO - jsonschema == 2.5.1 08:14:22 INFO - manifestparser == 1.1 08:14:22 INFO - mozInstall == 1.12 08:14:22 INFO - mozcrash == 0.17 08:14:22 INFO - mozdebug == 0.1 08:14:22 INFO - mozdevice == 0.48 08:14:22 INFO - mozfile == 1.2 08:14:22 INFO - mozhttpd == 0.7 08:14:22 INFO - mozinfo == 0.9 08:14:22 INFO - mozleak == 0.1 08:14:22 INFO - mozlog == 3.3 08:14:22 INFO - moznetwork == 0.27 08:14:22 INFO - mozprocess == 0.23 08:14:22 INFO - mozprofile == 0.28 08:14:22 INFO - mozrunner == 6.12 08:14:22 INFO - mozscreenshot == 0.1 08:14:22 INFO - mozsystemmonitor == 0.3 08:14:22 INFO - moztest == 0.7 08:14:22 INFO - mozversion == 1.4 08:14:22 INFO - psutil == 3.1.1 08:14:22 INFO - requests == 1.2.3 08:14:22 INFO - wsgiref == 0.1.2 08:14:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:22 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 08:14:22 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 08:14:22 INFO - Using env: {'DISPLAY': ':0', 08:14:22 INFO - 'HOME': '/home/cltbld', 08:14:22 INFO - 'LANG': 'en_US.UTF-8', 08:14:22 INFO - 'LANGUAGE': 'en_US:en', 08:14:22 INFO - 'LOGNAME': 'cltbld', 08:14:22 INFO - 'MAIL': '/var/mail/cltbld', 08:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:22 INFO - 'MOZ_NO_REMOTE': '1', 08:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:22 INFO - 'NO_EM_RESTART': '1', 08:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:22 INFO - 'PWD': '/builds/slave/test', 08:14:22 INFO - 'SHELL': '/bin/bash', 08:14:22 INFO - 'SHLVL': '1', 08:14:22 INFO - 'TERM': 'linux', 08:14:22 INFO - 'TMOUT': '86400', 08:14:22 INFO - 'USER': 'cltbld', 08:14:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:22 INFO - '_': '/tools/buildbot/bin/python'} 08:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 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)) 08:14:22 INFO - Cleaning up... 08:14:22 INFO - Return code: 0 08:14:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 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 0x7ff22c838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x262d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, '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': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', '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 08:14:22 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 08:14:22 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 08:14:22 INFO - Using env: {'DISPLAY': ':0', 08:14:22 INFO - 'HOME': '/home/cltbld', 08:14:22 INFO - 'LANG': 'en_US.UTF-8', 08:14:22 INFO - 'LANGUAGE': 'en_US:en', 08:14:22 INFO - 'LOGNAME': 'cltbld', 08:14:22 INFO - 'MAIL': '/var/mail/cltbld', 08:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:22 INFO - 'MOZ_NO_REMOTE': '1', 08:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:22 INFO - 'NO_EM_RESTART': '1', 08:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:22 INFO - 'PWD': '/builds/slave/test', 08:14:22 INFO - 'SHELL': '/bin/bash', 08:14:22 INFO - 'SHLVL': '1', 08:14:22 INFO - 'TERM': 'linux', 08:14:22 INFO - 'TMOUT': '86400', 08:14:22 INFO - 'USER': 'cltbld', 08:14:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:22 INFO - '_': '/tools/buildbot/bin/python'} 08:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:22 INFO - Cleaning up... 08:14:22 INFO - Return code: 0 08:14:22 INFO - Running post-action listener: _resource_record_post_action 08:14:22 INFO - Running post-action listener: _start_resource_monitoring 08:14:22 INFO - Starting resource monitoring. 08:14:22 INFO - [mozharness: 2016-09-02 15:14:22.581711Z] Finished create-virtualenv step (success) 08:14:22 INFO - [mozharness: 2016-09-02 15:14:22.582218Z] Running install step. 08:14:22 INFO - Running pre-action listener: _resource_record_pre_action 08:14:22 INFO - Running main action method: install 08:14:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:22 INFO - Reading from file tmpfile_stdout 08:14:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:22 INFO - Reading from file tmpfile_stdout 08:14:22 INFO - Output received: 08:14:22 INFO - Usage: mozinstall [options] installer 08:14:22 INFO - Options: 08:14:22 INFO - -h, --help show this help message and exit 08:14:22 INFO - -d DEST, --destination=DEST 08:14:22 INFO - Directory to install application into. [default: 08:14:22 INFO - "/builds/slave/test"] 08:14:22 INFO - --app=APP Application being installed. [default: firefox] 08:14:22 INFO - mkdir: /builds/slave/test/build/application 08:14:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:14:39 INFO - Reading from file tmpfile_stdout 08:14:39 INFO - Output received: 08:14:39 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:39 INFO - Running post-action listener: _resource_record_post_action 08:14:39 INFO - [mozharness: 2016-09-02 15:14:39.873959Z] Finished install step (success) 08:14:39 INFO - [mozharness: 2016-09-02 15:14:39.874211Z] Running run-tests step. 08:14:39 INFO - Running pre-action listener: _resource_record_pre_action 08:14:39 INFO - Running main action method: run_tests 08:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:39 INFO - Python 2.7.3 08:14:39 INFO - Return code: 0 08:14:39 INFO - grabbing minidump binary from tooltool 08:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:39 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 0x2628370>, '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 0x262b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262bd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:39 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 08:14:39 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 08:14:39 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 08:14:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:39 INFO - Return code: 0 08:14:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:14:39 INFO - Using env: {'DISPLAY': ':0', 08:14:39 INFO - 'HOME': '/home/cltbld', 08:14:39 INFO - 'LANG': 'en_US.UTF-8', 08:14:39 INFO - 'LANGUAGE': 'en_US:en', 08:14:39 INFO - 'LOGNAME': 'cltbld', 08:14:39 INFO - 'MAIL': '/var/mail/cltbld', 08:14:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:39 INFO - 'MOZ_NO_REMOTE': '1', 08:14:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:39 INFO - 'NO_EM_RESTART': '1', 08:14:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:39 INFO - 'PWD': '/builds/slave/test', 08:14:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:39 INFO - 'SHELL': '/bin/bash', 08:14:39 INFO - 'SHLVL': '1', 08:14:39 INFO - 'TERM': 'linux', 08:14:39 INFO - 'TMOUT': '86400', 08:14:39 INFO - 'USER': 'cltbld', 08:14:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117', 08:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:39 INFO - '_': '/tools/buildbot/bin/python'} 08:14:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:14:40 INFO - mozversion application_buildid: 20160902053001 08:14:40 INFO - mozversion application_changeset: 884f60cd86d31b32ec4883246ace726bc93e445b 08:14:40 INFO - mozversion application_display_name: Nightly 08:14:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:40 INFO - mozversion application_name: Firefox 08:14:40 INFO - mozversion application_remotingname: firefox 08:14:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:14:40 INFO - mozversion application_vendor: Mozilla 08:14:40 INFO - mozversion application_version: 51.0a1 08:14:40 INFO - mozversion platform_buildid: 20160902053001 08:14:40 INFO - mozversion platform_changeset: 884f60cd86d31b32ec4883246ace726bc93e445b 08:14:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:40 INFO - mozversion platform_version: 51.0a1 08:14:40 INFO - using testdate: 1472829280 08:14:40 INFO - actual date: 1472829280 08:14:40 INFO - starting webserver on 'localhost:49307' 08:14:40 INFO - SUITE-START | Running 2 tests 08:14:40 INFO - TEST-START | dromaeo_css 08:14:40 INFO - operating with platform_type : linux_ 08:14:40 INFO - Initialising browser for dromaeo_css test... 08:14:40 INFO - TEST-INFO | started process 3608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboGGvg/profile http://localhost:49307/getInfo.html) 08:14:44 INFO - PROCESS | 3608 | __metrics Screen width/height:1600/1200 08:14:44 INFO - PROCESS | 3608 | colorDepth:24 08:14:44 INFO - PROCESS | 3608 | Browser inner width/height: 1024/697 08:14:44 INFO - PROCESS | 3608 | __metrics 08:14:45 INFO - PROCESS | 3608 | 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" 08:14:45 INFO - PROCESS | 3608 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:45 INFO - PROCESS | 3608 | console.error: PushService: 08:14:45 INFO - PROCESS | 3608 | stateChangeProcessEnqueue: Error transitioning state 08:14:45 INFO - PROCESS | 3608 | UnknownError 08:14:46 INFO - TEST-INFO | 3608: exit 0 08:14:46 INFO - Browser initialized. 08:14:46 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:46 INFO - TEST-INFO | started process 3688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboGGvg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:58 INFO - PROCESS | 3688 | RSS: Main: 178941952 08:14:58 INFO - PROCESS | 3688 | 08:15:50 INFO - PROCESS | 3688 | 1472829350328 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] 08:17:59 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49307/tests/dromaeo/cssquery-ext.html) 08:18:00 INFO - PROCESS | 3688 | RSS: Main: 279228416 08:18:00 INFO - PROCESS | 3688 | 08:21:02 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-ext.html (next: http://localhost:49307/tests/dromaeo/cssquery-jquery.html) 08:21:03 INFO - PROCESS | 3688 | RSS: Main: 267972608 08:21:03 INFO - PROCESS | 3688 | 08:24:05 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49307/tests/dromaeo/cssquery-mootools.html) 08:24:06 INFO - PROCESS | 3688 | RSS: Main: 212934656 08:24:06 INFO - PROCESS | 3688 | 08:27:08 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49307/tests/dromaeo/cssquery-prototype.html) 08:27:08 INFO - PROCESS | 3688 | RSS: Main: 257028096 08:27:08 INFO - PROCESS | 3688 | 08:30:11 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49307/tests/dromaeo/cssquery-yui.html) 08:30:12 INFO - PROCESS | 3688 | RSS: Main: 216698880 08:30:12 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:49307/tests/dromaeo/cssquery-yui.html (next: http://localhost:49307/tests/dromaeo/cssquery-dojo.html) 08:33:15 INFO - PROCESS | 3688 | RSS: Main: 297349120 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | __start_tp_report 08:33:15 INFO - PROCESS | 3688 | _x_x_mozilla_page_load 08:33:15 INFO - PROCESS | 3688 | _x_x_mozilla_page_load_details 08:33:15 INFO - PROCESS | 3688 | |i|pagename|runs| 08:33:15 INFO - PROCESS | 3688 | |0;dojo.html;3004.8197108173513;3008.383281427308;3017.8038427502224;3048.862801173947;3067.5552044953483;5104.387473503176;5154.664946778456;5192.662476939001;5271.9472805271935;5313.920291195635;5169;5196.92204616931;5198.298229738984;5231.529162375386;5251.133562962116;4659.464161621423;4733.668643194977;4741.312509686093;4759.571638552529;4902.485239049902;4832.468428472883;4853.902921941559;4875.463698993108;4877.487863774306;4906.558409743122;4704.364910737058;4718.056388722235;4729.432468103815;4773.665843390964;4784.42586889572;4714.175019371596;4717.127331443694;4723.433188017426;4766.38037055184;4838.782254798542;4706.882327941795;4745.976270118662;4749.358836557055;4795.784189711471;4810.182269014241;5105.540501354896;5132.589392848563;5247.370315562119;5262.7631756571045;5298.231756395301;5564.33228012637;5594.664320140804;5598.1322894951345;5598.720063996784;5637.661740295554;5621.662700237958;5649.322081350264;5652.689102099383;5659.377468478464;5662.292213473316;5090.847274581768;5149.948500515022;5198.350206224222;5204.71374074422;5243.344581927259;5703.800366987136;5710.857228569236;5711.371749107595;5712.80005199816;5774.989376859117;5460.754266058037;5463.726813659301;5466.398696143421;5475.288212532425;5478.041342765;5397.541208997201;5405.972865155608;5474.562035037187;5475.206095116186;5517.69652669099;5465.9180112298345;5474.069408200616;5474.288342515527;5483.150111732688;5529.142982837667;5463.235147079412;5497.45025497447;5498.037843377473;5508.14623733322;5569.693666848281;4297.785110744513;4322.956770432255;4337.652987760972;4379.189849877719;4386.407834942306;3897.8635747748694;3924;3936.4488971544006;3960.2277555876326;3967.900802479903;5320.122179840283;5320.521153096162;5323.52088312046;5327.493888080626;5329.360476742738;5524.917126243109;5555.194496797942;5608.887822243532;5627.409122042209;5628;5348.1442969124755;5396.3524377075;5438.782448702087;5444.727763611803;5452.809151679751;4875.658703890694;4894.045661096124;4899;4899.779509922062;4957.231629097496;5782;5862.325832529228;5864.120381942743;5869;5870.354261031283;5423;5504.146857237135;5522.420145884785;5533.2253484513;5627.577931655224;5739.053056245672;5751.5398768099285;5752.13717942312;5801.622894511843;5802.854928626818;5470.753816078206;5472.890542189213;5474.233607295061;5475;5476.17857321405;5468.91796623059;5510.614257002132;5579.525740311957;5582.218489411404;5635.182898479616;5465.426130256265;5505.559555235652;5509.944900550943;5558.610897237317;5580.35825880029;5452.100403433389;5488.9725551371985;5494.752736126804;5498.285222920995;5506.421825708243;5312.4156342803035;5380.354357477127;5421.430749771217;5447.64590301645;5506.697131657797;5532.585056120887;5533.418991006048;5543.334799824047;5589.413111623384;5589.944100558942;5407.324084489439;5409.78360865561;5413.9729301353245;5420.620556561003;5424.376196737426 08:33:15 INFO - PROCESS | 3688 | |1;ext.html;584.2492397269509;591.3820058039348;600.327633050983;614.8893199224141;623.7099748616894;31347.84326078369;34117;43182;43536.78231608838;43718;45176.64470065903;45494.090118197615;45608.54391456093;45612;45854.541454585444;8874.689385871496;9032.14194651507;9040.231580315682;9042;9046.683366082189;8846.071162527938;8943.060978597252;8944.495541248461;8945.105489451067;8948.194662480375;8970.282377409823;9027.232685221765;9038.322125840556;9041.547922603877;9041.954790226073;8935.597898094602;8938.731838044869;8975.596098175598;8976.551172441385;8988.32587555936;8866.069062748447;8918.286537077018;8920.197182253563;8933.955330223307;8941.463512189224;41570.37644435336;42275.15449690989;42434.78782606098;42448.78775606102;42569.57430425687;3261.902142935692;3324.8337583120747;3367.5285460035616;3367.8652853885815;3487.9128021799656;32535.39585774141;32728.836355818068;32846.6715332846;32951.50572741411;33013.83493082543;4173.144505376421;4387.3638322443385;4407.449068866392;4573.63410927125;4575.084983003379;359248;359285;359648;359891;360234.7659589345;55548.16677749837;55774.72112639492;55824.72087639617;55841.72079139578;55867.44132558704;58137.127943080886;58265.41734582685;58297;58321;58340.4165958335;16144.112073836051;16442;16455.341786328412;16463.176841157896;16464.588385290463;12759.42582583786;12908.225506469642;12941.09412341127;12947.158434701714;12948.805767913489;11979.520819167135;15315.846841531666;15340.15629140408;15354.539363819104;15640.608984775472;4915.066137433876;5621.747021384048;5684.54523638108;5709.25779648643;5756.194132821408;892.7857314244535;937.1612406895927;988.7330420786348;1028.923518679144;1035.2597892506894;30250;30418.84790576033;30537.38925221483;30873.84563077215;30912.69087309143;1056.1550759392455;1074.6561100447939;1104.3539529375246;1134.1323887226279;1203.9939800301117;15340.92329538345;15926.601834953986;16071.437499687689;16101.758473622906;16364.181790910407;483695;488951;489736;490921;493916;53964;54362.45637543574;54531;54561.45438545643;54561.72719136379;1197.6706405738316;1222.8410306660255;1289.335991964139;1312.3569450968957;1357.6062941746782;28600.57099143556;32593.511097334034;33201.33597328088;33284;33725.3254934895;47779.28331075106;55137.44862551323;56941;57234;62261.06608400968;383334;383802;384352;385240;389066;26391.34021649474;26618.467630647665;26730.732692672824;27540.862295688392;28019.579706304015;43747.78126109349;44279;44293.55706442894;44656;44872.32691509565;39026.609733902296;39072.603544990525;39481.40777888276;40790.38814417727;40928.79535602303;38244.80877595594;38662.420063698504;39572;40051.79974100111;40801.79599102104;38845.11548845206;39237.41143882787;40097.198056038134;40272.3959140619;41608;32827.67172328246;36718;37060.402617462816;37605.81197094107;38010;27133.86433067822;27689.307767305978;28232.43535129327;28304.15087547377;28603.570946436237 08:33:15 INFO - PROCESS | 3688 | |2;jquery.html;380.18260739410283;398.2512875793508;403.9798010099494;406.6990427083957;419.0947553284905;15365.615859603515;18529;18587.907060464713;18775.436736897882;18923.24307027717;18336.541586460346;18505.629887402276;18736.344227952024;18974.335898243564;19011.334603288855;5031.484198026124;5447.618666693333;5675.971620141893;5707.086866101425;5708.628939118965;4161.875143745678;5551.444855514456;5681.9431805681825;6066.726997285133;6381.553291269613;6426.646534440604;6432.356764323577;6434.131392262031;6437.5815571987905;6437.613743175401;6153.4154255345675;6231.937680623181;6275.215598050244;6280.371962803706;6289.96855015722;5380.515753582196;5563.972180139114;5567.526760225345;5568.248286481314;5610.49505544503;21756.34730958074;21987.560248794933;22065.558688826135;22252.777472225232;22348.553028939332;2162.643163877958;2195.7804219578074;2242.4505996031075;2252.3243027091808;2277.943051423728;13269.402876870565;13557.457701691921;13565.593032208952;14561.635959101;14808.925955370261;1837.6232872261287;1887.8017808130223;1890.8770929889513;1927.4603111128906;1959.4023822734061;77381;79354.78714369953;80887;81205.59397203036;81212.59393702993;10350.741231469274;10633.415162166;10725.892741072645;10906.836397454044;10950.616728414627;14105.929470352788;14133.939954503454;14135.64660883486;14139.222342771041;14159.575212743634;7860.567668778158;7896.289333959971;7897;8131.390145739093;8155.469894456842;7508.249175082448;7558.58427786477;7786.532808031537;7803.921960780433;7815.68737250515;6312.242530896322;6440.291567927524;6462.806115816533;6472.126262954535;6555.344465553502;1742.1985886492103;1844.1148248840632;1858.5539470526976;1920.9135588898532;2004.9699254511195;917.8806755121791;940.9153176214173;1003.4882210072915;1010.7523656704008;1032.4682788363998;17611.55971100733;18707;18842.15210315539;19032.809671903382;19437.125329360213;956.2636769687302;971.723058928202;988.1995583577325;989.559645957542;997.9700608981742;9936.671215143007;10147.391156530632;10274.178065754722;10577.894221057844;10631.255812093234;479611;484594;484622;487049;488765;86015.13984860196;94959;96037;97601.51199244101;98535.50732246293;944.414463032924;1027.3271007489957;1046.7749433871754;1076.6070384309671;1083.2200815412891;15526.146061966248;16850.831491684927;17369;17439.47681569555;17740.29038838432;41333.37999929943;41692.58307416887;41788.79105604452;42228.57771422246;43092.78453607712;51244.74377628088;54376;59186.70406647939;61134.38865611465;61569.692151540745;8360.414770966217;8422.663093476438;8652.480851148952;8665.740027799176;8866.73399798007;12166.45250963691;13230.206187628773;13297.26865022433;13318.933405332911;13514.256715880721;11298.60454884108;11376.715582110513;11482.483288252215;11804.468798903898;11872.46573904159;11512.481938312963;11635.709107272385;11798.764024719287;11866.584669536525;11962.820557691815;11702.122340824302;11883.405829708652;11884.286942783461;12295.87704122983;12319.260844349368;8547.529885856338;8618.310535157298;8760.38677292609;8930.598123084606;8946.329025322997;10805.351678898976;11385.715357116138;11531.942340288246;11612.361320127475;11885.643430697093 08:33:15 INFO - PROCESS | 3688 | |3;mootools.html;1490.731668299706;1510.3731951240234;1675.9413420530284;1771.9734203986934;1798.4245041586698;7836.529808211511;8504.702335418262;8592.355573331994;9161.587728552215;9167.266618670506;8734.344924130684;9075.591598378072;9090.31822613305;9091.18179363857;9099.31755118367;2385.1771138957074;2407.0612461140167;2409.771071748181;2412.9034838606435;2415.6738840256517;1983.990080049605;2048.1500177426424;2333.439974406139;2366.597678394677;2404.302752201859;2064.370367038053;2297.4026753044245;2370.395549134968;2383.1420688552107;2390.53384590005;2322.210448447536;2323.9651405228933;2327.918522851709;2331.0326214620914;2336.264076815806;2277.1233075265977;2320.7331156916835;2323.7211534615785;2325.093213646679;2332.521833024243;8900.51047192404;8984.32617553686;9031.051739567316;9052.728418147466;9053;5184;5206.609504287156;5257.106291930381;5315.920261196085;5326.014687282865;3126;3235;3406.386850366933;3410.36908171989;3424.298018906118;1021.7598864266891;1025.4001409175642;1042.5621239079605;1049.2235745548317;1061.5223149582641;12473.50105995759;12480.313582752944;12480.50077996879;12482.188657737308;12492.687682807911;4511.390962220124;4568.360429539867;4650.232711602615;4673.859784206479;4718.009218064176;10672.786544269227;10674.62638807638;10675.786484270426;10686.465676716132;10700.143988480902;5262.158054711228;5276.314079169761;5294.735263236823;5302.867428314323;5306.416294207634;4716.528347165256;4840.806367745321;4848.224284114524;4881.487443818419;4914.287428322873;3823.6558709715705;3884.3590807517007;3946.625070618287;3996.160806230666;4011.5787842276723;1188;1195.9402029898645;1203.8735932727113;1209.4255228766442;1215.1190386969377;784.4469648897514;846.4963346808639;924.3206243411088;944.3861490031397;954.4988880837616;5964.224650795369;5986.880262394728;6046.969765151146;6183.628982261079;6310.684465776692;671.787423700216;957.8898426680881;969.7139343893568;978.188103873783;1004.1163775877181;3819.4652748614662;3964.960350396517;4101.036256479725;4299.828006879752;4325.589069038437;10752.301100428447;11295;11347.432628368548;11351.886481135083;11353.545858165746;11018.44907754609;11256.774864502664;11276.097912167006;11280.887191128148;11431.314121152758;8203.630836612367;8458.450200736932;8469.110743372104;8476.872846907301;8478.194571515696;5912.763489460373;5954.225950626391;6005.87988240224;6017.157597936205;6194.659293738888;9625.56684949165;10295.588176472857;10381.221408394249;10390.532426040696;10474.633387831389;10205.897941020496;10279.126274266771;10398.844017339594;10418.843717344094;10427.791444171226;7780.377569794516;7793.337566306927;7955.164707705608;7960.84078318442;7964.20357964199;8584.613692383982;8595.742127736177;8668.089850565852;8674.436161649724;8676.175763302475;7658.4639075264195;7761.340286075747;7805.804854878674;7833.09919359281;7967.123616402307;7524.849503010018;7550.471466997257;7591.278828511283;7616.0860696716745;7631.046119235096;7092.042574252616;7205.459590530836;7212.531185472927;7214.603196824225;7224.446743950076;5146.459621739664;5237.240600112886;5239.318888544465;5254.080535906278;5462.562994960314;5072.59419246452;5131.769070391916;5157.174852023658;5186.533212010937;5293.7353132344 08:33:15 INFO - PROCESS | 3688 | |4;prototype.html;326.5564099863057;337.7871940677373;339.5874013074114;341.93674170278484;342.8611412377987;5054.393472783262;5191.610629202811;5199.738113920447;5294.973525132374;5330.173823057423;5184.922226166611;5189.766460509277;5191.117510023296;5208.635395522306;5225.346831646044;4074.449949256842;4076.7757773322455;4078.4086307485395;4082.6121518455698;4111.1366613011305;3862.633049860259;3993.2013597280516;4070.1859628074358;4077.9592204078026;4086.9591304086875;3987.684064258802;4003.15933653933;4004.7597144171295;4011.257917285297;4015.1768887378016;4006.4390985262085;4009.8797036088963;4018.557958624549;4022.8189731462007;4031.637152656275;3581.6418358164237;3591.8742844000594;3595.1012246938267;3598.6401359864067;3609.4044482660593;4895.681780684244;5100.438951715309;5114.539691427789;5116.334876466073;5141.665791723563;4654.813807447698;4655.86032419028;4691.812327506896;4702.412198475156;4708.4820669726305;5389.487998640162;5406.648567843077;5412.404635490093;5419.160030195287;5424.240606315119;3845.2309538092213;3924.529056513208;3942.5071866016747;3946.921061578781;3969.4442778011103;5607.214989901417;5608.747606357683;5610.316904928505;5628.0713682242795;5631.380548139701;4048.0891799344913;4073.327900896319;4079.510978492888;4080.897977550585;4090.754554726726;3923.2545816294814;4103.097318589965;4115.382692596135;4120.464339635828;4134.565870583606;4645.465771436328;4650;4660.207764680013;4662.6269898408045;4663.626909847204;5433.212184233264;5435.728213589384;5449.3188351456065;5472.589555783332;5513.669179849222;1388.8680575345327;1406.1914399220284;1442.4086124688827;1443.2278730879138;1447.3125265499013;989.4459102902398;1001.4291853643354;1005.5726316315537;1014.6955913226003;1022.9795404091876;5142.742862856842;5221.686698798008;5229.555487783505;5251.317328747238;5275.966319366303;5439.456054394529;5458;5474.835754927359;5508.421615730371;5524.33707955048;5044.2685810558;5222.660527065728;5234.581233501311;5248.160294352885;5275.8129420879995;2936.588877557144;2948.793584449068;2951.8081324713826;2952.6161598991994;2955.8078724883244;5784.847258244267;5790.507806836382;5790.681512516852;5809.7966571170655;5815.680137592389;5530.6128570999645;5596.244506991586;5684.687342196136;5688.829335119953;5689.68706721126;5789.421057894177;5802.970985145047;5814.680192589448;5817.712992159416;5828.650280983239;5376.973115134556;5541.944580554143;5615.298087739033;5615.691136987341;5618.943810562006;5531.557475401878;5535.142052981794;5539.529140023144;5547.0570003098765;5554.250176226158;5801.477866991991;5804.216430781959;5814.622049566765;5824.563157763269;5839.708014599168;3942.822572984165;4039.5152581690386;4043.251998380309;4066.9389959151226;4068.247374235776;5391.245225668488;5413.729313534229;5545.861353466034;5552.140033088799;5586.357568879468;5407.432219617041;5428;5447.155690867922;5454.781808727606;5454.836354909359;5388.137897936312;5401.189821526802;5430.321209848769;5437.265969094122;5448.964696707613;5167.896642067213;5341.813036543703;5353.411124776194;5377.596680249075;5390.434004429635;5444.618876678753;5450.5367043801725;5482.5613950883035;5490.286262785812;5502.9174562382395;5208.713520756243;5356.839294821161;5371.979323928441;5398.514133727984;5421.295231620022 08:33:15 INFO - PROCESS | 3688 | |5;yui.html;656.7569999100334;696.2689176364815;706.1596699927089;713.7002458967237;729.5367441674539;14508.347124379401;14922.104673719585;14942.252887355644;15010.624734381647;15134.924325378386;14367.712645747079;14380.640483987905;14396.784048239284;14462.132272063684;14717.264136793172;803.052398170159;823.8352329534117;824.6536454689045;826.0747962282252;826.7354446577098;668.8361351468897;798.9920100798976;815.6166601697222;818.705266104202;824.2622852546967;871.6077765005741;871.6252011634995;873.1748497669673;873.2141073034256;874.2263097159029;862.8317478091775;865.1132589096195;865.5109862927426;865.6018231613465;865.8398196333699;510.26521808595504;604.9788257410969;618.6999305336908;621.7761605821901;623.7692053940071;13669.179849209078;13698.315084245747;13704.725905481935;13707.246101464416;13724;13547.932260338734;14053.367598458093;14168.645783855383;14195.541429653553;14371.137731736024;12395.75208495825;12495.068393270047;12568.434420451102;12655;13191;4375.343698445226;4388.275934470808;4408.955910440886;4624.352590637313;4643.721376717408;78387;78590.60704696497;82510.58744706298;82828.75756863713;84476.57761711151;10432.895671043345;10553.314034587727;10780.676579702622;10785.78428431427;10825.729356766144;21312.78687213108;21315.46711332229;21340;21355.466113346978;21356.466088347606;7874.291313781787;7940.563269020144;7973.2824045835;7984.600769961478;8228.42401031922;4363.563643635611;4403.889902752393;4449.710768800082;4547.295169248771;4568.198388047228;3305.5537502437346;3405.0976491229844;3416.692497675221;3419.777714448553;3423.8972830815114;588.3381196154327;588.3586890289605;594.8275000249879;595.6098755315276;596.4006173795394;664.5945972956492;667.1560475997867;680.2857000149921;683.9042534045237;694.8649480340289;8731.519766412908;9274.30442716799;9329.90670093304;9360;9503.239740820718;523.7983376400038;591.3265458751722;668.9596729973562;680.7038938061959;693.4868197533789;4092.4884389451317;4338.913221735547;4352.542982986804;4356.869293921188;4388.188185185751;70874.64562677257;96550.03449965411;96564.51717741367;124919;129935;100533.49733251287;102688.48655756674;103204;106443;107178.46410768053;76635.61682191664;76760.2535644999;93293;94535;97587;9157;9572.615453706023;9617.471039092918;9764;9801.215902727907;50956.49043509518;51358.48641513687;51378.71553211199;51436;52557.737211313695;66990.33009670036;76155.61922190353;77254.2274577247;78519;79984.20015799768;12666.809997849856;12723.93638031841;13150.671233219246;13334.599962001155;13366.131201471873;14491.92754036223;14534.273286335852;14690.485832995793;14732.705345893237;14762.852371476149;12823.87176128264;13091.934540327238;13385.129966552144;13391.732165356832;13859;13346.599602011567;13874.375653095432;13961.301934903417;13997;14165.645858853612;13474.003310663835;13542.59372218835;13596.184228946295;14058.578242652737;14458.710825783635;8664.566771661517;10566.31318964265;10777.515011824644;11057.336559806437;11231.71920701989;9400.727359923223;10108.848367274644;10484.895151048697;11189.888101118884;11228.719282018015 08:33:15 INFO - PROCESS | 3688 | __end_tp_report 08:33:15 INFO - PROCESS | 3688 | __start_cc_report 08:33:15 INFO - PROCESS | 3688 | _x_x_mozilla_cycle_collect,864 08:33:15 INFO - PROCESS | 3688 | __end_cc_report 08:33:15 INFO - PROCESS | 3688 | __startTimestamp1472830395497__endTimestamp 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | ------- Summary: start ------- 08:33:15 INFO - PROCESS | 3688 | Number of tests: 6 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | [#0] dojo.html Cycles:165 Average:5202.69 Median:5424.38 stddev:571.28 (10.5%) stddev-sans-first:546.40 08:33:15 INFO - PROCESS | 3688 | Values: 3004.8 3008.4 3017.8 3048.9 3067.6 5104.4 5154.7 5192.7 5271.9 5313.9 5169.0 5196.9 5198.3 5231.5 5251.1 4659.5 4733.7 4741.3 4759.6 4902.5 4832.5 4853.9 4875.5 4877.5 4906.6 4704.4 4718.1 4729.4 4773.7 4784.4 4714.2 4717.1 4723.4 4766.4 4838.8 4706.9 4746.0 4749.4 4795.8 4810.2 5105.5 5132.6 5247.4 5262.8 5298.2 5564.3 5594.7 5598.1 5598.7 5637.7 5621.7 5649.3 5652.7 5659.4 5662.3 5090.8 5149.9 5198.4 5204.7 5243.3 5703.8 5710.9 5711.4 5712.8 5775.0 5460.8 5463.7 5466.4 5475.3 5478.0 5397.5 5406.0 5474.6 5475.2 5517.7 5465.9 5474.1 5474.3 5483.2 5529.1 5463.2 5497.5 5498.0 5508.1 5569.7 4297.8 4323.0 4337.7 4379.2 4386.4 3897.9 3924.0 3936.4 3960.2 3967.9 5320.1 5320.5 5323.5 5327.5 5329.4 5524.9 5555.2 5608.9 5627.4 5628.0 5348.1 5396.4 5438.8 5444.7 5452.8 4875.7 4894.0 4899.0 4899.8 4957.2 5782.0 5862.3 5864.1 5869.0 5870.4 5423.0 5504.1 5522.4 5533.2 5627.6 5739.1 5751.5 5752.1 5801.6 5802.9 5470.8 5472.9 5474.2 5475.0 5476.2 5468.9 5510.6 5579.5 5582.2 5635.2 5465.4 5505.6 5509.9 5558.6 5580.4 5452.1 5489.0 5494.8 5498.3 5506.4 5312.4 5380.4 5421.4 5447.6 5506.7 5532.6 5533.4 5543.3 5589.4 5589.9 5407.3 5409.8 5414.0 5420.6 5424.4 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | [#1] ext.html Cycles:180 Average:57182.60 Median:40796.09 stddev:109798.58 (269.1%) stddev-sans-first:110024.36 08:33:15 INFO - PROCESS | 3688 | Values: 584.2 591.4 600.3 614.9 623.7 31347.8 34117.0 43182.0 43536.8 43718.0 45176.6 45494.1 45608.5 45612.0 45854.5 8874.7 9032.1 9040.2 9042.0 9046.7 8846.1 8943.1 8944.5 8945.1 8948.2 8970.3 9027.2 9038.3 9041.5 9042.0 8935.6 8938.7 8975.6 8976.6 8988.3 8866.1 8918.3 8920.2 8934.0 8941.5 41570.4 42275.2 42434.8 42448.8 42569.6 3261.9 3324.8 3367.5 3367.9 3487.9 32535.4 32728.8 32846.7 32951.5 33013.8 4173.1 4387.4 4407.4 4573.6 4575.1 359248.0 359285.0 359648.0 359891.0 360234.8 55548.2 55774.7 55824.7 55841.7 55867.4 58137.1 58265.4 58297.0 58321.0 58340.4 16144.1 16442.0 16455.3 16463.2 16464.6 12759.4 12908.2 12941.1 12947.2 12948.8 11979.5 15315.8 15340.2 15354.5 15640.6 4915.1 5621.7 5684.5 5709.3 5756.2 892.8 937.2 988.7 1028.9 1035.3 30250.0 30418.8 30537.4 30873.8 30912.7 1056.2 1074.7 1104.4 1134.1 1204.0 15340.9 15926.6 16071.4 16101.8 16364.2 483695.0 488951.0 489736.0 490921.0 493916.0 53964.0 54362.5 54531.0 54561.5 54561.7 1197.7 1222.8 1289.3 1312.4 1357.6 28600.6 32593.5 33201.3 33284.0 33725.3 47779.3 55137.4 56941.0 57234.0 62261.1 383334.0 383802.0 384352.0 385240.0 389066.0 26391.3 26618.5 26730.7 27540.9 28019.6 43747.8 44279.0 44293.6 44656.0 44872.3 39026.6 39072.6 39481.4 40790.4 40928.8 38244.8 38662.4 39572.0 40051.8 40801.8 38845.1 39237.4 40097.2 40272.4 41608.0 32827.7 36718.0 37060.4 37605.8 38010.0 27133.9 27689.3 28232.4 28304.2 28603.6 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | [#2] jquery.html Cycles:180 Average:28911.89 Median:1329.06 stddev:80011.35 (6020.1%) stddev-sans-first:80207.12 08:33:15 INFO - PROCESS | 3688 | Values: 380.2 398.3 404.0 406.7 419.1 15365.6 18529.0 18587.9 18775.4 18923.2 18336.5 18505.6 18736.3 18974.3 19011.3 5031.5 5447.6 5676.0 5707.1 5708.6 4161.9 5551.4 5681.9 6066.7 6381.6 6426.6 6432.4 6434.1 6437.6 6437.6 6153.4 6231.9 6275.2 6280.4 6290.0 5380.5 5564.0 5567.5 5568.2 5610.5 21756.3 21987.6 22065.6 22252.8 22348.6 2162.6 2195.8 2242.5 2252.3 2277.9 13269.4 13557.5 13565.6 14561.6 14808.9 1837.6 1887.8 1890.9 1927.5 1959.4 77381.0 79354.8 80887.0 81205.6 81212.6 10350.7 10633.4 10725.9 10906.8 10950.6 14105.9 14133.9 14135.6 14139.2 14159.6 7860.6 7896.3 7897.0 8131.4 8155.5 7508.2 7558.6 7786.5 7803.9 7815.7 6312.2 6440.3 6462.8 6472.1 6555.3 1742.2 1844.1 1858.6 1920.9 2005.0 917.9 940.9 1003.5 1010.8 1032.5 17611.6 18707.0 18842.2 19032.8 19437.1 956.3 971.7 988.2 989.6 998.0 9936.7 10147.4 10274.2 10577.9 10631.3 479611.0 484594.0 484622.0 487049.0 488765.0 86015.1 94959.0 96037.0 97601.5 98535.5 944.4 1027.3 1046.8 1076.6 1083.2 15526.1 16850.8 17369.0 17439.5 17740.3 41333.4 41692.6 41788.8 42228.6 43092.8 51244.7 54376.0 59186.7 61134.4 61569.7 8360.4 8422.7 8652.5 8665.7 8866.7 12166.5 13230.2 13297.3 13318.9 13514.3 11298.6 11376.7 11482.5 11804.5 11872.5 11512.5 11635.7 11798.8 11866.6 11962.8 11702.1 11883.4 11884.3 12295.9 12319.3 8547.5 8618.3 8760.4 8930.6 8946.3 10805.4 11385.7 11531.9 11612.4 11885.6 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | [#3] mootools.html Cycles:180 Average:5878.12 Median:4779.41 stddev:3390.04 (70.9%) stddev-sans-first:3383.51 08:33:15 INFO - PROCESS | 3688 | Values: 1490.7 1510.4 1675.9 1772.0 1798.4 7836.5 8504.7 8592.4 9161.6 9167.3 8734.3 9075.6 9090.3 9091.2 9099.3 2385.2 2407.1 2409.8 2412.9 2415.7 1984.0 2048.2 2333.4 2366.6 2404.3 2064.4 2297.4 2370.4 2383.1 2390.5 2322.2 2324.0 2327.9 2331.0 2336.3 2277.1 2320.7 2323.7 2325.1 2332.5 8900.5 8984.3 9031.1 9052.7 9053.0 5184.0 5206.6 5257.1 5315.9 5326.0 3126.0 3235.0 3406.4 3410.4 3424.3 1021.8 1025.4 1042.6 1049.2 1061.5 12473.5 12480.3 12480.5 12482.2 12492.7 4511.4 4568.4 4650.2 4673.9 4718.0 10672.8 10674.6 10675.8 10686.5 10700.1 5262.2 5276.3 5294.7 5302.9 5306.4 4716.5 4840.8 4848.2 4881.5 4914.3 3823.7 3884.4 3946.6 3996.2 4011.6 1188.0 1195.9 1203.9 1209.4 1215.1 784.4 846.5 924.3 944.4 954.5 5964.2 5986.9 6047.0 6183.6 6310.7 671.8 957.9 969.7 978.2 1004.1 3819.5 3965.0 4101.0 4299.8 4325.6 10752.3 11295.0 11347.4 11351.9 11353.5 11018.4 11256.8 11276.1 11280.9 11431.3 8203.6 8458.5 8469.1 8476.9 8478.2 5912.8 5954.2 6005.9 6017.2 6194.7 9625.6 10295.6 10381.2 10390.5 10474.6 10205.9 10279.1 10398.8 10418.8 10427.8 7780.4 7793.3 7955.2 7960.8 7964.2 8584.6 8595.7 8668.1 8674.4 8676.2 7658.5 7761.3 7805.8 7833.1 7967.1 7524.8 7550.5 7591.3 7616.1 7631.0 7092.0 7205.5 7212.5 7214.6 7224.4 5146.5 5237.2 5239.3 5254.1 5462.6 5072.6 5131.8 5157.2 5186.5 5293.7 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | [#4] prototype.html Cycles:180 Average:4595.72 Median:5222.17 stddev:1335.21 (25.6%) stddev-sans-first:1299.94 08:33:15 INFO - PROCESS | 3688 | Values: 326.6 337.8 339.6 341.9 342.9 5054.4 5191.6 5199.7 5295.0 5330.2 5184.9 5189.8 5191.1 5208.6 5225.3 4074.4 4076.8 4078.4 4082.6 4111.1 3862.6 3993.2 4070.2 4078.0 4087.0 3987.7 4003.2 4004.8 4011.3 4015.2 4006.4 4009.9 4018.6 4022.8 4031.6 3581.6 3591.9 3595.1 3598.6 3609.4 4895.7 5100.4 5114.5 5116.3 5141.7 4654.8 4655.9 4691.8 4702.4 4708.5 5389.5 5406.6 5412.4 5419.2 5424.2 3845.2 3924.5 3942.5 3946.9 3969.4 5607.2 5608.7 5610.3 5628.1 5631.4 4048.1 4073.3 4079.5 4080.9 4090.8 3923.3 4103.1 4115.4 4120.5 4134.6 4645.5 4650.0 4660.2 4662.6 4663.6 5433.2 5435.7 5449.3 5472.6 5513.7 1388.9 1406.2 1442.4 1443.2 1447.3 989.4 1001.4 1005.6 1014.7 1023.0 5142.7 5221.7 5229.6 5251.3 5276.0 5439.5 5458.0 5474.8 5508.4 5524.3 5044.3 5222.7 5234.6 5248.2 5275.8 2936.6 2948.8 2951.8 2952.6 2955.8 5784.8 5790.5 5790.7 5809.8 5815.7 5530.6 5596.2 5684.7 5688.8 5689.7 5789.4 5803.0 5814.7 5817.7 5828.7 5377.0 5541.9 5615.3 5615.7 5618.9 5531.6 5535.1 5539.5 5547.1 5554.3 5801.5 5804.2 5814.6 5824.6 5839.7 3942.8 4039.5 4043.3 4066.9 4068.2 5391.2 5413.7 5545.9 5552.1 5586.4 5407.4 5428.0 5447.2 5454.8 5454.8 5388.1 5401.2 5430.3 5437.3 5449.0 5167.9 5341.8 5353.4 5377.6 5390.4 5444.6 5450.5 5482.6 5490.3 5502.9 5208.7 5356.8 5372.0 5398.5 5421.3 08:33:15 INFO - PROCESS | 3688 | 08:33:15 INFO - PROCESS | 3688 | [#5] yui.html Cycles:180 Average:20713.47 Median:4498.50 stddev:30116.33 (669.5%) stddev-sans-first:30163.16 08:33:15 INFO - PROCESS | 3688 | Values: 656.8 696.3 706.2 713.7 729.5 14508.3 14922.1 14942.3 15010.6 15134.9 14367.7 14380.6 14396.8 14462.1 14717.3 803.1 823.8 824.7 826.1 826.7 668.8 799.0 815.6 818.7 824.3 871.6 871.6 873.2 873.2 874.2 862.8 865.1 865.5 865.6 865.8 510.3 605.0 618.7 621.8 623.8 13669.2 13698.3 13704.7 13707.2 13724.0 13547.9 14053.4 14168.6 14195.5 14371.1 12395.8 12495.1 12568.4 12655.0 13191.0 4375.3 4388.3 4409.0 4624.4 4643.7 78387.0 78590.6 82510.6 82828.8 84476.6 10432.9 10553.3 10780.7 10785.8 10825.7 21312.8 21315.5 21340.0 21355.5 21356.5 7874.3 7940.6 7973.3 7984.6 8228.4 4363.6 4403.9 4449.7 4547.3 4568.2 3305.6 3405.1 3416.7 3419.8 3423.9 588.3 588.4 594.8 595.6 596.4 664.6 667.2 680.3 683.9 694.9 8731.5 9274.3 9329.9 9360.0 9503.2 523.8 591.3 669.0 680.7 693.5 4092.5 4338.9 4352.5 4356.9 4388.2 70874.6 96550.0 96564.5 124919.0 129935.0 100533.5 102688.5 103204.0 106443.0 107178.5 76635.6 76760.3 93293.0 94535.0 97587.0 9157.0 9572.6 9617.5 9764.0 9801.2 50956.5 51358.5 51378.7 51436.0 52557.7 66990.3 76155.6 77254.2 78519.0 79984.2 12666.8 12723.9 13150.7 13334.6 13366.1 14491.9 14534.3 14690.5 14732.7 14762.9 12823.9 13091.9 13385.1 13391.7 13859.0 13346.6 13874.4 13961.3 13997.0 14165.6 13474.0 13542.6 13596.2 14058.6 14458.7 8664.6 10566.3 10777.5 11057.3 11231.7 9400.7 10108.8 10484.9 11189.9 11228.7 08:33:15 INFO - PROCESS | 3688 | -------- Summary: end -------- 08:33:15 INFO - PROCESS | 3688 | 08:33:16 INFO - TEST-INFO | 3688: exit 0 08:33:16 INFO - TEST-OK | dromaeo_css | took 1116272ms 08:33:16 INFO - TEST-START | kraken 08:33:16 INFO - operating with platform_type : linux_ 08:33:16 INFO - Initialising browser for kraken test... 08:33:16 INFO - TEST-INFO | started process 3994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDtdTnr/profile http://localhost:49307/getInfo.html) 08:33:21 INFO - PROCESS | 3994 | __metrics Screen width/height:1600/1200 08:33:21 INFO - PROCESS | 3994 | colorDepth:24 08:33:21 INFO - PROCESS | 3994 | Browser inner width/height: 1024/697 08:33:21 INFO - PROCESS | 3994 | __metrics 08:33:21 INFO - PROCESS | 3994 | 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" 08:33:21 INFO - PROCESS | 3994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:22 INFO - PROCESS | 3994 | console.error: PushService: 08:33:22 INFO - PROCESS | 3994 | stateChangeProcessEnqueue: Error transitioning state 08:33:22 INFO - PROCESS | 3994 | UnknownError 08:33:22 INFO - TEST-INFO | 3994: exit 0 08:33:22 INFO - Browser initialized. 08:33:22 INFO - Running cycle 1/1 for kraken test... 08:33:22 INFO - TEST-INFO | started process 4076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDtdTnr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:34 INFO - PROCESS | 4076 | RSS: Main: 179126272 08:33:34 INFO - PROCESS | 4076 | 08:33:37 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:38 INFO - PROCESS | 4076 | RSS: Main: 233611264 08:33:38 INFO - PROCESS | 4076 | 08:33:40 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-dft) 08:33:41 INFO - PROCESS | 4076 | RSS: Main: 223850496 08:33:41 INFO - PROCESS | 4076 | 08:33:44 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-fft) 08:33:45 INFO - PROCESS | 4076 | RSS: Main: 301383680 08:33:45 INFO - PROCESS | 4076 | 08:33:47 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49307/tests/kraken/driver.html?testName=audio-oscillator) 08:33:47 INFO - PROCESS | 4076 | RSS: Main: 211943424 08:33:47 INFO - PROCESS | 4076 | 08:33:50 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:50 INFO - PROCESS | 4076 | RSS: Main: 213430272 08:33:50 INFO - PROCESS | 4076 | 08:33:53 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49307/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:54 INFO - PROCESS | 4076 | RSS: Main: 252170240 08:33:54 INFO - PROCESS | 4076 | 08:33:57 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49307/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:58 INFO - PROCESS | 4076 | RSS: Main: 251043840 08:33:58 INFO - PROCESS | 4076 | 08:34:01 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49307/tests/kraken/driver.html?testName=json-parse-financial) 08:34:01 INFO - PROCESS | 4076 | RSS: Main: 250851328 08:34:01 INFO - PROCESS | 4076 | 08:34:03 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:03 INFO - PROCESS | 4076 | RSS: Main: 213188608 08:34:03 INFO - PROCESS | 4076 | 08:34:05 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:06 INFO - PROCESS | 4076 | RSS: Main: 221327360 08:34:06 INFO - PROCESS | 4076 | 08:34:08 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:08 INFO - PROCESS | 4076 | RSS: Main: 221855744 08:34:08 INFO - PROCESS | 4076 | 08:34:11 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:12 INFO - PROCESS | 4076 | RSS: Main: 222945280 08:34:12 INFO - PROCESS | 4076 | 08:34:14 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:15 INFO - PROCESS | 4076 | RSS: Main: 221425664 08:34:15 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:49307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49307/tests/kraken/driver.html?testName=ai-astar) 08:34:17 INFO - PROCESS | 4076 | RSS: Main: 272154624 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | __start_tp_report 08:34:17 INFO - PROCESS | 4076 | _x_x_mozilla_page_load 08:34:17 INFO - PROCESS | 4076 | _x_x_mozilla_page_load_details 08:34:17 INFO - PROCESS | 4076 | |i|pagename|runs| 08:34:17 INFO - PROCESS | 4076 | |0;ai-astar;112;111;116;110;112;111;111;111;111;127 08:34:17 INFO - PROCESS | 4076 | |1;audio-beat-detection;151;116;146;191;122;146;147;119;187;119 08:34:17 INFO - PROCESS | 4076 | |2;audio-dft;161;161;160;160;161;161;162;163;162;161 08:34:17 INFO - PROCESS | 4076 | |3;audio-fft;75;73;75;166;77;77;76;75;160;76 08:34:17 INFO - PROCESS | 4076 | |4;audio-oscillator;82;82;145;84;82;82;144;83;81;147 08:34:17 INFO - PROCESS | 4076 | |5;imaging-gaussian-blur;116;116;117;118;117;117;118;117;117;117 08:34:17 INFO - PROCESS | 4076 | |6;imaging-darkroom;145;146;146;146;146;146;146;146;147;145 08:34:17 INFO - PROCESS | 4076 | |7;imaging-desaturate;96;96;96;96;96;95;95;95;97;96 08:34:17 INFO - PROCESS | 4076 | |8;json-parse-financial;54;52;55;53;54;53;56;54;54;54 08:34:17 INFO - PROCESS | 4076 | |9;json-stringify-tinderbox;60;60;61;60;60;60;60;60;60;61 08:34:17 INFO - PROCESS | 4076 | |10;stanford-crypto-aes;82;84;80;79;88;81;84;78;78;79 08:34:17 INFO - PROCESS | 4076 | |11;stanford-crypto-ccm;124;123;122;125;129;127;125;123;174;122 08:34:17 INFO - PROCESS | 4076 | |12;stanford-crypto-pbkdf2;167;165;167;168;165;163;165;162;163;163 08:34:17 INFO - PROCESS | 4076 | |13;stanford-crypto-sha256-iterative;65;64;66;65;64;67;64;65;70;65 08:34:17 INFO - PROCESS | 4076 | __end_tp_report 08:34:17 INFO - PROCESS | 4076 | __start_cc_report 08:34:17 INFO - PROCESS | 4076 | _x_x_mozilla_cycle_collect,1685 08:34:17 INFO - PROCESS | 4076 | __end_cc_report 08:34:17 INFO - PROCESS | 4076 | __startTimestamp1472830457367__endTimestamp 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | ------- Summary: start ------- 08:34:17 INFO - PROCESS | 4076 | Number of tests: 14 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#0] ai-astar Cycles:10 Average:113.20 Median:111.50 stddev:5.12 (4.6%) stddev-sans-first:5.41 08:34:17 INFO - PROCESS | 4076 | Values: 112.0 111.0 116.0 110.0 112.0 111.0 111.0 111.0 111.0 127.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:146.50 stddev:27.16 (18.5%) stddev-sans-first:28.71 08:34:17 INFO - PROCESS | 4076 | Values: 151.0 116.0 146.0 191.0 122.0 146.0 147.0 119.0 187.0 119.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 08:34:17 INFO - PROCESS | 4076 | Values: 161.0 161.0 160.0 160.0 161.0 161.0 162.0 163.0 162.0 161.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.50 stddev:36.94 (48.9%) stddev-sans-first:38.60 08:34:17 INFO - PROCESS | 4076 | Values: 75.0 73.0 75.0 166.0 77.0 77.0 76.0 75.0 160.0 76.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:82.00 stddev:30.47 (37.2%) stddev-sans-first:31.52 08:34:17 INFO - PROCESS | 4076 | Values: 82.0 82.0 145.0 84.0 82.0 82.0 144.0 83.0 81.0 147.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 08:34:17 INFO - PROCESS | 4076 | Values: 116.0 116.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 08:34:17 INFO - PROCESS | 4076 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:34:17 INFO - PROCESS | 4076 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 97.0 96.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:1.17 08:34:17 INFO - PROCESS | 4076 | Values: 54.0 52.0 55.0 53.0 54.0 53.0 56.0 54.0 54.0 54.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:34:17 INFO - PROCESS | 4076 | Values: 60.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:3.23 (4.0%) stddev-sans-first:3.42 08:34:17 INFO - PROCESS | 4076 | Values: 82.0 84.0 80.0 79.0 88.0 81.0 84.0 78.0 78.0 79.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:125.00 stddev:15.83 (12.7%) stddev-sans-first:16.67 08:34:17 INFO - PROCESS | 4076 | Values: 124.0 123.0 122.0 125.0 129.0 127.0 125.0 123.0 174.0 122.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:2.04 (1.2%) stddev-sans-first:2.01 08:34:17 INFO - PROCESS | 4076 | Values: 167.0 165.0 167.0 168.0 165.0 163.0 165.0 162.0 163.0 163.0 08:34:17 INFO - PROCESS | 4076 | 08:34:17 INFO - PROCESS | 4076 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:1.84 (2.8%) stddev-sans-first:1.94 08:34:17 INFO - PROCESS | 4076 | Values: 65.0 64.0 66.0 65.0 64.0 67.0 64.0 65.0 70.0 65.0 08:34:17 INFO - PROCESS | 4076 | -------- Summary: end -------- 08:34:17 INFO - PROCESS | 4076 | 08:34:18 INFO - TEST-INFO | 4076: exit 0 08:34:18 INFO - TEST-OK | kraken | took 62196ms 08:34:18 INFO - SUITE-END | took 1178s 08:34:19 INFO - Completed test suite (00:19:38) 08:34:19 INFO - javascript benchmark 08:34:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3004.8197108173513, 3008.383281427308, 3017.8038427502224, 3048.862801173947, 3067.5552044953483, 5104.387473503176, 5154.664946778456, 5192.662476939001, 5271.9472805271935, 5313.920291195635, 5169.0, 5196.92204616931, 5198.298229738984, 5231.529162375386, 5251.133562962116, 4659.464161621423, 4733.668643194977, 4741.312509686093, 4759.571638552529, 4902.485239049902, 4832.468428472883, 4853.902921941559, 4875.463698993108, 4877.487863774306, 4906.558409743122, 4704.364910737058, 4718.056388722235, 4729.432468103815, 4773.665843390964, 4784.42586889572, 4714.175019371596, 4717.127331443694, 4723.433188017426, 4766.38037055184, 4838.782254798542, 4706.882327941795, 4745.976270118662, 4749.358836557055, 4795.784189711471, 4810.182269014241, 5105.540501354896, 5132.589392848563, 5247.370315562119, 5262.7631756571045, 5298.231756395301, 5564.33228012637, 5594.664320140804, 5598.1322894951345, 5598.720063996784, 5637.661740295554, 5621.662700237958, 5649.322081350264, 5652.689102099383, 5659.377468478464, 5662.292213473316, 5090.847274581768, 5149.948500515022, 5198.350206224222, 5204.71374074422, 5243.344581927259, 5703.800366987136, 5710.857228569236, 5711.371749107595, 5712.80005199816, 5774.989376859117, 5460.754266058037, 5463.726813659301, 5466.398696143421, 5475.288212532425, 5478.041342765, 5397.541208997201, 5405.972865155608, 5474.562035037187, 5475.206095116186, 5517.69652669099, 5465.9180112298345, 5474.069408200616, 5474.288342515527, 5483.150111732688, 5529.142982837667, 5463.235147079412, 5497.45025497447, 5498.037843377473, 5508.14623733322, 5569.693666848281, 4297.785110744513, 4322.956770432255, 4337.652987760972, 4379.189849877719, 4386.407834942306, 3897.8635747748694, 3924.0, 3936.4488971544006, 3960.2277555876326, 3967.900802479903, 5320.122179840283, 5320.521153096162, 5323.52088312046, 5327.493888080626, 5329.360476742738, 5524.917126243109, 5555.194496797942, 5608.887822243532, 5627.409122042209, 5628.0, 5348.1442969124755, 5396.3524377075, 5438.782448702087, 5444.727763611803, 5452.809151679751, 4875.658703890694, 4894.045661096124, 4899.0, 4899.779509922062, 4957.231629097496, 5782.0, 5862.325832529228, 5864.120381942743, 5869.0, 5870.354261031283, 5423.0, 5504.146857237135, 5522.420145884785, 5533.2253484513, 5627.577931655224, 5739.053056245672, 5751.5398768099285, 5752.13717942312, 5801.622894511843, 5802.854928626818, 5470.753816078206, 5472.890542189213, 5474.233607295061, 5475.0, 5476.17857321405, 5468.91796623059, 5510.614257002132, 5579.525740311957, 5582.218489411404, 5635.182898479616, 5465.426130256265, 5505.559555235652, 5509.944900550943, 5558.610897237317, 5580.35825880029, 5452.100403433389, 5488.9725551371985, 5494.752736126804, 5498.285222920995, 5506.421825708243, 5312.4156342803035, 5380.354357477127, 5421.430749771217, 5447.64590301645, 5506.697131657797, 5532.585056120887, 5533.418991006048, 5543.334799824047, 5589.413111623384, 5589.944100558942, 5407.324084489439, 5409.78360865561, 5413.9729301353245, 5420.620556561003, 5424.376196737426], "value": 5165.194760777688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.2492397269509, 591.3820058039348, 600.327633050983, 614.8893199224141, 623.7099748616894, 31347.84326078369, 34117.0, 43182.0, 43536.78231608838, 43718.0, 45176.64470065903, 45494.090118197615, 45608.54391456093, 45612.0, 45854.541454585444, 8874.689385871496, 9032.14194651507, 9040.231580315682, 9042.0, 9046.683366082189, 8846.071162527938, 8943.060978597252, 8944.495541248461, 8945.105489451067, 8948.194662480375, 8970.282377409823, 9027.232685221765, 9038.322125840556, 9041.547922603877, 9041.954790226073, 8935.597898094602, 8938.731838044869, 8975.596098175598, 8976.551172441385, 8988.32587555936, 8866.069062748447, 8918.286537077018, 8920.197182253563, 8933.955330223307, 8941.463512189224, 41570.37644435336, 42275.15449690989, 42434.78782606098, 42448.78775606102, 42569.57430425687, 3261.902142935692, 3324.8337583120747, 3367.5285460035616, 3367.8652853885815, 3487.9128021799656, 32535.39585774141, 32728.836355818068, 32846.6715332846, 32951.50572741411, 33013.83493082543, 4173.144505376421, 4387.3638322443385, 4407.449068866392, 4573.63410927125, 4575.084983003379, 359248.0, 359285.0, 359648.0, 359891.0, 360234.7659589345, 55548.16677749837, 55774.72112639492, 55824.72087639617, 55841.72079139578, 55867.44132558704, 58137.127943080886, 58265.41734582685, 58297.0, 58321.0, 58340.4165958335, 16144.112073836051, 16442.0, 16455.341786328412, 16463.176841157896, 16464.588385290463, 12759.42582583786, 12908.225506469642, 12941.09412341127, 12947.158434701714, 12948.805767913489, 11979.520819167135, 15315.846841531666, 15340.15629140408, 15354.539363819104, 15640.608984775472, 4915.066137433876, 5621.747021384048, 5684.54523638108, 5709.25779648643, 5756.194132821408, 892.7857314244535, 937.1612406895927, 988.7330420786348, 1028.923518679144, 1035.2597892506894, 30250.0, 30418.84790576033, 30537.38925221483, 30873.84563077215, 30912.69087309143, 1056.1550759392455, 1074.6561100447939, 1104.3539529375246, 1134.1323887226279, 1203.9939800301117, 15340.92329538345, 15926.601834953986, 16071.437499687689, 16101.758473622906, 16364.181790910407, 483695.0, 488951.0, 489736.0, 490921.0, 493916.0, 53964.0, 54362.45637543574, 54531.0, 54561.45438545643, 54561.72719136379, 1197.6706405738316, 1222.8410306660255, 1289.335991964139, 1312.3569450968957, 1357.6062941746782, 28600.57099143556, 32593.511097334034, 33201.33597328088, 33284.0, 33725.3254934895, 47779.28331075106, 55137.44862551323, 56941.0, 57234.0, 62261.06608400968, 383334.0, 383802.0, 384352.0, 385240.0, 389066.0, 26391.34021649474, 26618.467630647665, 26730.732692672824, 27540.862295688392, 28019.579706304015, 43747.78126109349, 44279.0, 44293.55706442894, 44656.0, 44872.32691509565, 39026.609733902296, 39072.603544990525, 39481.40777888276, 40790.38814417727, 40928.79535602303, 38244.80877595594, 38662.420063698504, 39572.0, 40051.79974100111, 40801.79599102104, 38845.11548845206, 39237.41143882787, 40097.198056038134, 40272.3959140619, 41608.0, 32827.67172328246, 36718.0, 37060.402617462816, 37605.81197094107, 38010.0, 27133.86433067822, 27689.307767305978, 28232.43535129327, 28304.15087547377, 28603.570946436237], "value": 19450.269612171654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.18260739410283, 398.2512875793508, 403.9798010099494, 406.6990427083957, 419.0947553284905, 15365.615859603515, 18529.0, 18587.907060464713, 18775.436736897882, 18923.24307027717, 18336.541586460346, 18505.629887402276, 18736.344227952024, 18974.335898243564, 19011.334603288855, 5031.484198026124, 5447.618666693333, 5675.971620141893, 5707.086866101425, 5708.628939118965, 4161.875143745678, 5551.444855514456, 5681.9431805681825, 6066.726997285133, 6381.553291269613, 6426.646534440604, 6432.356764323577, 6434.131392262031, 6437.5815571987905, 6437.613743175401, 6153.4154255345675, 6231.937680623181, 6275.215598050244, 6280.371962803706, 6289.96855015722, 5380.515753582196, 5563.972180139114, 5567.526760225345, 5568.248286481314, 5610.49505544503, 21756.34730958074, 21987.560248794933, 22065.558688826135, 22252.777472225232, 22348.553028939332, 2162.643163877958, 2195.7804219578074, 2242.4505996031075, 2252.3243027091808, 2277.943051423728, 13269.402876870565, 13557.457701691921, 13565.593032208952, 14561.635959101, 14808.925955370261, 1837.6232872261287, 1887.8017808130223, 1890.8770929889513, 1927.4603111128906, 1959.4023822734061, 77381.0, 79354.78714369953, 80887.0, 81205.59397203036, 81212.59393702993, 10350.741231469274, 10633.415162166, 10725.892741072645, 10906.836397454044, 10950.616728414627, 14105.929470352788, 14133.939954503454, 14135.64660883486, 14139.222342771041, 14159.575212743634, 7860.567668778158, 7896.289333959971, 7897.0, 8131.390145739093, 8155.469894456842, 7508.249175082448, 7558.58427786477, 7786.532808031537, 7803.921960780433, 7815.68737250515, 6312.242530896322, 6440.291567927524, 6462.806115816533, 6472.126262954535, 6555.344465553502, 1742.1985886492103, 1844.1148248840632, 1858.5539470526976, 1920.9135588898532, 2004.9699254511195, 917.8806755121791, 940.9153176214173, 1003.4882210072915, 1010.7523656704008, 1032.4682788363998, 17611.55971100733, 18707.0, 18842.15210315539, 19032.809671903382, 19437.125329360213, 956.2636769687302, 971.723058928202, 988.1995583577325, 989.559645957542, 997.9700608981742, 9936.671215143007, 10147.391156530632, 10274.178065754722, 10577.894221057844, 10631.255812093234, 479611.0, 484594.0, 484622.0, 487049.0, 488765.0, 86015.13984860196, 94959.0, 96037.0, 97601.51199244101, 98535.50732246293, 944.414463032924, 1027.3271007489957, 1046.7749433871754, 1076.6070384309671, 1083.2200815412891, 15526.146061966248, 16850.831491684927, 17369.0, 17439.47681569555, 17740.29038838432, 41333.37999929943, 41692.58307416887, 41788.79105604452, 42228.57771422246, 43092.78453607712, 51244.74377628088, 54376.0, 59186.70406647939, 61134.38865611465, 61569.692151540745, 8360.414770966217, 8422.663093476438, 8652.480851148952, 8665.740027799176, 8866.73399798007, 12166.45250963691, 13230.206187628773, 13297.26865022433, 13318.933405332911, 13514.256715880721, 11298.60454884108, 11376.715582110513, 11482.483288252215, 11804.468798903898, 11872.46573904159, 11512.481938312963, 11635.709107272385, 11798.764024719287, 11866.584669536525, 11962.820557691815, 11702.122340824302, 11883.405829708652, 11884.286942783461, 12295.87704122983, 12319.260844349368, 8547.529885856338, 8618.310535157298, 8760.38677292609, 8930.598123084606, 8946.329025322997, 10805.351678898976, 11385.715357116138, 11531.942340288246, 11612.361320127475, 11885.643430697093], "value": 9299.189666552142, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.731668299706, 1510.3731951240234, 1675.9413420530284, 1771.9734203986934, 1798.4245041586698, 7836.529808211511, 8504.702335418262, 8592.355573331994, 9161.587728552215, 9167.266618670506, 8734.344924130684, 9075.591598378072, 9090.31822613305, 9091.18179363857, 9099.31755118367, 2385.1771138957074, 2407.0612461140167, 2409.771071748181, 2412.9034838606435, 2415.6738840256517, 1983.990080049605, 2048.1500177426424, 2333.439974406139, 2366.597678394677, 2404.302752201859, 2064.370367038053, 2297.4026753044245, 2370.395549134968, 2383.1420688552107, 2390.53384590005, 2322.210448447536, 2323.9651405228933, 2327.918522851709, 2331.0326214620914, 2336.264076815806, 2277.1233075265977, 2320.7331156916835, 2323.7211534615785, 2325.093213646679, 2332.521833024243, 8900.51047192404, 8984.32617553686, 9031.051739567316, 9052.728418147466, 9053.0, 5184.0, 5206.609504287156, 5257.106291930381, 5315.920261196085, 5326.014687282865, 3126.0, 3235.0, 3406.386850366933, 3410.36908171989, 3424.298018906118, 1021.7598864266891, 1025.4001409175642, 1042.5621239079605, 1049.2235745548317, 1061.5223149582641, 12473.50105995759, 12480.313582752944, 12480.50077996879, 12482.188657737308, 12492.687682807911, 4511.390962220124, 4568.360429539867, 4650.232711602615, 4673.859784206479, 4718.009218064176, 10672.786544269227, 10674.62638807638, 10675.786484270426, 10686.465676716132, 10700.143988480902, 5262.158054711228, 5276.314079169761, 5294.735263236823, 5302.867428314323, 5306.416294207634, 4716.528347165256, 4840.806367745321, 4848.224284114524, 4881.487443818419, 4914.287428322873, 3823.6558709715705, 3884.3590807517007, 3946.625070618287, 3996.160806230666, 4011.5787842276723, 1188.0, 1195.9402029898645, 1203.8735932727113, 1209.4255228766442, 1215.1190386969377, 784.4469648897514, 846.4963346808639, 924.3206243411088, 944.3861490031397, 954.4988880837616, 5964.224650795369, 5986.880262394728, 6046.969765151146, 6183.628982261079, 6310.684465776692, 671.787423700216, 957.8898426680881, 969.7139343893568, 978.188103873783, 1004.1163775877181, 3819.4652748614662, 3964.960350396517, 4101.036256479725, 4299.828006879752, 4325.589069038437, 10752.301100428447, 11295.0, 11347.432628368548, 11351.886481135083, 11353.545858165746, 11018.44907754609, 11256.774864502664, 11276.097912167006, 11280.887191128148, 11431.314121152758, 8203.630836612367, 8458.450200736932, 8469.110743372104, 8476.872846907301, 8478.194571515696, 5912.763489460373, 5954.225950626391, 6005.87988240224, 6017.157597936205, 6194.659293738888, 9625.56684949165, 10295.588176472857, 10381.221408394249, 10390.532426040696, 10474.633387831389, 10205.897941020496, 10279.126274266771, 10398.844017339594, 10418.843717344094, 10427.791444171226, 7780.377569794516, 7793.337566306927, 7955.164707705608, 7960.84078318442, 7964.20357964199, 8584.613692383982, 8595.742127736177, 8668.089850565852, 8674.436161649724, 8676.175763302475, 7658.4639075264195, 7761.340286075747, 7805.804854878674, 7833.09919359281, 7967.123616402307, 7524.849503010018, 7550.471466997257, 7591.278828511283, 7616.0860696716745, 7631.046119235096, 7092.042574252616, 7205.459590530836, 7212.531185472927, 7214.603196824225, 7224.446743950076, 5146.459621739664, 5237.240600112886, 5239.318888544465, 5254.080535906278, 5462.562994960314, 5072.59419246452, 5131.769070391916, 5157.174852023658, 5186.533212010937, 5293.7353132344], "value": 4658.953742062597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5564099863057, 337.7871940677373, 339.5874013074114, 341.93674170278484, 342.8611412377987, 5054.393472783262, 5191.610629202811, 5199.738113920447, 5294.973525132374, 5330.173823057423, 5184.922226166611, 5189.766460509277, 5191.117510023296, 5208.635395522306, 5225.346831646044, 4074.449949256842, 4076.7757773322455, 4078.4086307485395, 4082.6121518455698, 4111.1366613011305, 3862.633049860259, 3993.2013597280516, 4070.1859628074358, 4077.9592204078026, 4086.9591304086875, 3987.684064258802, 4003.15933653933, 4004.7597144171295, 4011.257917285297, 4015.1768887378016, 4006.4390985262085, 4009.8797036088963, 4018.557958624549, 4022.8189731462007, 4031.637152656275, 3581.6418358164237, 3591.8742844000594, 3595.1012246938267, 3598.6401359864067, 3609.4044482660593, 4895.681780684244, 5100.438951715309, 5114.539691427789, 5116.334876466073, 5141.665791723563, 4654.813807447698, 4655.86032419028, 4691.812327506896, 4702.412198475156, 4708.4820669726305, 5389.487998640162, 5406.648567843077, 5412.404635490093, 5419.160030195287, 5424.240606315119, 3845.2309538092213, 3924.529056513208, 3942.5071866016747, 3946.921061578781, 3969.4442778011103, 5607.214989901417, 5608.747606357683, 5610.316904928505, 5628.0713682242795, 5631.380548139701, 4048.0891799344913, 4073.327900896319, 4079.510978492888, 4080.897977550585, 4090.754554726726, 3923.2545816294814, 4103.097318589965, 4115.382692596135, 4120.464339635828, 4134.565870583606, 4645.465771436328, 4650.0, 4660.207764680013, 4662.6269898408045, 4663.626909847204, 5433.212184233264, 5435.728213589384, 5449.3188351456065, 5472.589555783332, 5513.669179849222, 1388.8680575345327, 1406.1914399220284, 1442.4086124688827, 1443.2278730879138, 1447.3125265499013, 989.4459102902398, 1001.4291853643354, 1005.5726316315537, 1014.6955913226003, 1022.9795404091876, 5142.742862856842, 5221.686698798008, 5229.555487783505, 5251.317328747238, 5275.966319366303, 5439.456054394529, 5458.0, 5474.835754927359, 5508.421615730371, 5524.33707955048, 5044.2685810558, 5222.660527065728, 5234.581233501311, 5248.160294352885, 5275.8129420879995, 2936.588877557144, 2948.793584449068, 2951.8081324713826, 2952.6161598991994, 2955.8078724883244, 5784.847258244267, 5790.507806836382, 5790.681512516852, 5809.7966571170655, 5815.680137592389, 5530.6128570999645, 5596.244506991586, 5684.687342196136, 5688.829335119953, 5689.68706721126, 5789.421057894177, 5802.970985145047, 5814.680192589448, 5817.712992159416, 5828.650280983239, 5376.973115134556, 5541.944580554143, 5615.298087739033, 5615.691136987341, 5618.943810562006, 5531.557475401878, 5535.142052981794, 5539.529140023144, 5547.0570003098765, 5554.250176226158, 5801.477866991991, 5804.216430781959, 5814.622049566765, 5824.563157763269, 5839.708014599168, 3942.822572984165, 4039.5152581690386, 4043.251998380309, 4066.9389959151226, 4068.247374235776, 5391.245225668488, 5413.729313534229, 5545.861353466034, 5552.140033088799, 5586.357568879468, 5407.432219617041, 5428.0, 5447.155690867922, 5454.781808727606, 5454.836354909359, 5388.137897936312, 5401.189821526802, 5430.321209848769, 5437.265969094122, 5448.964696707613, 5167.896642067213, 5341.813036543703, 5353.411124776194, 5377.596680249075, 5390.434004429635, 5444.618876678753, 5450.5367043801725, 5482.5613950883035, 5490.286262785812, 5502.9174562382395, 5208.713520756243, 5356.839294821161, 5371.979323928441, 5398.514133727984, 5421.295231620022], "value": 4179.106965079986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.7569999100334, 696.2689176364815, 706.1596699927089, 713.7002458967237, 729.5367441674539, 14508.347124379401, 14922.104673719585, 14942.252887355644, 15010.624734381647, 15134.924325378386, 14367.712645747079, 14380.640483987905, 14396.784048239284, 14462.132272063684, 14717.264136793172, 803.052398170159, 823.8352329534117, 824.6536454689045, 826.0747962282252, 826.7354446577098, 668.8361351468897, 798.9920100798976, 815.6166601697222, 818.705266104202, 824.2622852546967, 871.6077765005741, 871.6252011634995, 873.1748497669673, 873.2141073034256, 874.2263097159029, 862.8317478091775, 865.1132589096195, 865.5109862927426, 865.6018231613465, 865.8398196333699, 510.26521808595504, 604.9788257410969, 618.6999305336908, 621.7761605821901, 623.7692053940071, 13669.179849209078, 13698.315084245747, 13704.725905481935, 13707.246101464416, 13724.0, 13547.932260338734, 14053.367598458093, 14168.645783855383, 14195.541429653553, 14371.137731736024, 12395.75208495825, 12495.068393270047, 12568.434420451102, 12655.0, 13191.0, 4375.343698445226, 4388.275934470808, 4408.955910440886, 4624.352590637313, 4643.721376717408, 78387.0, 78590.60704696497, 82510.58744706298, 82828.75756863713, 84476.57761711151, 10432.895671043345, 10553.314034587727, 10780.676579702622, 10785.78428431427, 10825.729356766144, 21312.78687213108, 21315.46711332229, 21340.0, 21355.466113346978, 21356.466088347606, 7874.291313781787, 7940.563269020144, 7973.2824045835, 7984.600769961478, 8228.42401031922, 4363.563643635611, 4403.889902752393, 4449.710768800082, 4547.295169248771, 4568.198388047228, 3305.5537502437346, 3405.0976491229844, 3416.692497675221, 3419.777714448553, 3423.8972830815114, 588.3381196154327, 588.3586890289605, 594.8275000249879, 595.6098755315276, 596.4006173795394, 664.5945972956492, 667.1560475997867, 680.2857000149921, 683.9042534045237, 694.8649480340289, 8731.519766412908, 9274.30442716799, 9329.90670093304, 9360.0, 9503.239740820718, 523.7983376400038, 591.3265458751722, 668.9596729973562, 680.7038938061959, 693.4868197533789, 4092.4884389451317, 4338.913221735547, 4352.542982986804, 4356.869293921188, 4388.188185185751, 70874.64562677257, 96550.03449965411, 96564.51717741367, 124919.0, 129935.0, 100533.49733251287, 102688.48655756674, 103204.0, 106443.0, 107178.46410768053, 76635.61682191664, 76760.2535644999, 93293.0, 94535.0, 97587.0, 9157.0, 9572.615453706023, 9617.471039092918, 9764.0, 9801.215902727907, 50956.49043509518, 51358.48641513687, 51378.71553211199, 51436.0, 52557.737211313695, 66990.33009670036, 76155.61922190353, 77254.2274577247, 78519.0, 79984.20015799768, 12666.809997849856, 12723.93638031841, 13150.671233219246, 13334.599962001155, 13366.131201471873, 14491.92754036223, 14534.273286335852, 14690.485832995793, 14732.705345893237, 14762.852371476149, 12823.87176128264, 13091.934540327238, 13385.129966552144, 13391.732165356832, 13859.0, 13346.599602011567, 13874.375653095432, 13961.301934903417, 13997.0, 14165.645858853612, 13474.003310663835, 13542.59372218835, 13596.184228946295, 14058.578242652737, 14458.710825783635, 8664.566771661517, 10566.31318964265, 10777.515011824644, 11057.336559806437, 11231.71920701989, 9400.727359923223, 10108.848367274644, 10484.895151048697, 11189.888101118884, 11228.719282018015], "value": 7412.672799104808, "unit": "score"}], "name": "dromaeo_css", "value": 7161.01937464291, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 116.0, 110.0, 112.0, 111.0, 111.0, 111.0, 111.0, 127.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 146.0, 191.0, 122.0, 146.0, 147.0, 119.0, 187.0, 119.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 163.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 166.0, 77.0, 77.0, 76.0, 75.0, 160.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 145.0, 84.0, 82.0, 82.0, 144.0, 83.0, 81.0, 147.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 55.0, 53.0, 54.0, 53.0, 56.0, 54.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 80.0, 79.0, 88.0, 81.0, 84.0, 78.0, 78.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 122.0, 125.0, 129.0, 127.0, 125.0, 123.0, 174.0, 122.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 167.0, 168.0, 165.0, 163.0, 165.0, 162.0, 163.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 64.0, 67.0, 64.0, 65.0, 70.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1526.8, "alertThreshold": 2.0}]} 08:34:19 INFO - Return code: 0 08:34:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:19 INFO - # TBPL SUCCESS # 08:34:19 INFO - Running post-action listener: _resource_record_post_action 08:34:19 INFO - [mozharness: 2016-09-02 15:34:19.154844Z] Finished run-tests step (success) 08:34:19 INFO - Running post-run listener: _resource_record_post_run 08:34:19 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406716416; Read time: 12; Write time: 256408 08:34:19 INFO - TinderboxPrint: CPU usage
13.1% 08:34:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:34:19 INFO - TinderboxPrint: I/O write bytes / time
406,716,416 / 256,408 08:34:19 INFO - TinderboxPrint: CPU idle
8,296.4 (86.9%) 08:34:19 INFO - TinderboxPrint: CPU user
1,196.2 (12.5%) 08:34:19 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118190080; Read time: 0; Write time: 94844 08:34:19 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288526336; Read time: 0; Write time: 161564 08:34:19 INFO - Running post-run listener: _upload_blobber_files 08:34:19 INFO - Blob upload gear active. 08:34:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:19 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 08:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:20 INFO - (blobuploader) - INFO - Done attempting. 08:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:25 INFO - (blobuploader) - INFO - Done attempting. 08:34:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:25 INFO - (blobuploader) - INFO - Done attempting. 08:34:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:25 INFO - Return code: 0 08:34:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/393f94283fae96705827b460677e5680d85e553f8787965f379e31392acf24d420082e6399e7af8d0997f35fa6ed950aadf60e4469db016661089fad49c74902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edac5f7858ff96df50745169da58d4cd3cba1bd16c4d15972daf5e02e9060b5442f9048eb94cad67a678fb13f9b4d456d63f318d8e5d4b433b488ee73ca5ab7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f01a41514e466b622353841fe366494662e4d37179a32009df186be115dcc5d2fe4484b01f85ab4e91eafe98206e441ebff48b1d939541d3c2aaf67f4febeda"} 08:34:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:25 INFO - Contents: 08:34:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/393f94283fae96705827b460677e5680d85e553f8787965f379e31392acf24d420082e6399e7af8d0997f35fa6ed950aadf60e4469db016661089fad49c74902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edac5f7858ff96df50745169da58d4cd3cba1bd16c4d15972daf5e02e9060b5442f9048eb94cad67a678fb13f9b4d456d63f318d8e5d4b433b488ee73ca5ab7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f01a41514e466b622353841fe366494662e4d37179a32009df186be115dcc5d2fe4484b01f85ab4e91eafe98206e441ebff48b1d939541d3c2aaf67f4febeda"} 08:34:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:25 INFO - Copying logs to upload dir... 08:34:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.312444 ========= master_lag: 1.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-02 08:34:26.612591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 08:34:26.620068) ========= 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=920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117 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/sha512/393f94283fae96705827b460677e5680d85e553f8787965f379e31392acf24d420082e6399e7af8d0997f35fa6ed950aadf60e4469db016661089fad49c74902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edac5f7858ff96df50745169da58d4cd3cba1bd16c4d15972daf5e02e9060b5442f9048eb94cad67a678fb13f9b4d456d63f318d8e5d4b433b488ee73ca5ab7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f01a41514e466b622353841fe366494662e4d37179a32009df186be115dcc5d2fe4484b01f85ab4e91eafe98206e441ebff48b1d939541d3c2aaf67f4febeda"} build_url:https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/J9IIivQGTR2x1vP_dlL03w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/393f94283fae96705827b460677e5680d85e553f8787965f379e31392acf24d420082e6399e7af8d0997f35fa6ed950aadf60e4469db016661089fad49c74902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edac5f7858ff96df50745169da58d4cd3cba1bd16c4d15972daf5e02e9060b5442f9048eb94cad67a678fb13f9b4d456d63f318d8e5d4b433b488ee73ca5ab7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f01a41514e466b622353841fe366494662e4d37179a32009df186be115dcc5d2fe4484b01f85ab4e91eafe98206e441ebff48b1d939541d3c2aaf67f4febeda"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 08:34:26.647769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:34:26.648099) ========= 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=920470bf432669ad7e3a5387000001ca-1472828077.47374-459446117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:34:26.697512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 08:34:26.697875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 08:34:26.698158) ========= ========= Total master_lag: 1.29 =========