builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1468613137.8 results: success (0) buildid: 20160715063123 builduid: 8a4f06db217c4baab5c78d71b9d8350b revision: b6e311c419b5f15680b3fa56fd197c0e93dc40a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:37.799930) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:37.800407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:37.800685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:37.816671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:37.817089) ========= 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=52faae308a556c440401f8e5000001e8-1468613136.694900-96965533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 13:05:38-- 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% 46.6M=0s 2016-07-15 13:05:38 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128411 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.037842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.038168) ========= 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=52faae308a556c440401f8e5000001e8-1468613136.694900-96965533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017254 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.067668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.068015) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6e311c419b5f15680b3fa56fd197c0e93dc40a5 --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 b6e311c419b5f15680b3fa56fd197c0e93dc40a5 --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=52faae308a556c440401f8e5000001e8-1468613136.694900-96965533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 13:05:38,870 truncating revision to first 12 chars 2016-07-15 13:05:38,870 Setting DEBUG logging. 2016-07-15 13:05:38,870 attempt 1/10 2016-07-15 13:05:38,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6e311c419b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 13:05:39,226 unpacking tar archive at: fx-team-b6e311c419b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712420 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.860981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.861358) ========= script_repo_revision: b6e311c419b5f15680b3fa56fd197c0e93dc40a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.861786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.862054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 13:05:38.871195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-15 13:05:38.871646) ========= /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=52faae308a556c440401f8e5000001e8-1468613136.694900-96965533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:05:39 INFO - MultiFileLogger online at 20160715 13:05:39 in /builds/slave/test 13:05:39 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 13:05:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:05:39 INFO - {'append_to_log': False, 13:05:39 INFO - 'base_work_dir': '/builds/slave/test', 13:05:39 INFO - 'blob_upload_branch': 'Fx-Team', 13:05:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:05:39 INFO - 'branch': 'Fx-Team', 13:05:39 INFO - 'buildbot_json_path': 'buildprops.json', 13:05:39 INFO - 'config_files': ('talos/linux_config.py',), 13:05:39 INFO - 'default_actions': ('clobber', 13:05:39 INFO - 'read-buildbot-config', 13:05:39 INFO - 'download-and-extract', 13:05:39 INFO - 'populate-webroot', 13:05:39 INFO - 'create-virtualenv', 13:05:39 INFO - 'install', 13:05:39 INFO - 'run-tests'), 13:05:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:05:39 INFO - 'download_minidump_stackwalk': True, 13:05:39 INFO - 'download_symbols': 'ondemand', 13:05:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:05:39 INFO - 'tooltool.py': '/tools/tooltool.py', 13:05:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:05:39 INFO - '/tools/misc-python/virtualenv.py')}, 13:05:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:05:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:05:39 INFO - 'installer_path': 'installer.exe', 13:05:39 INFO - 'log_level': 'info', 13:05:39 INFO - 'log_name': 'talos', 13:05:39 INFO - 'log_to_console': True, 13:05:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:05:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:05:39 INFO - 'opt_config_files': (), 13:05:39 INFO - 'pip_index': False, 13:05:39 INFO - 'sps_profile': False, 13:05:39 INFO - 'sps_profile_interval': 0, 13:05:39 INFO - 'suite': 'dromaeojs', 13:05:39 INFO - 'system_bits': '32', 13:05:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:05:39 INFO - 'title': 'talos-linux64-ix-056', 13:05:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:05:39 INFO - 'use_talos_json': True, 13:05:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:05:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:05:39 INFO - 'work_dir': 'build'} 13:05:39 INFO - ##### 13:05:39 INFO - ##### Running clobber step. 13:05:39 INFO - ##### 13:05:39 INFO - Running pre-action listener: _resource_record_pre_action 13:05:39 INFO - Running main action method: clobber 13:05:39 INFO - rmtree: /builds/slave/test/build 13:05:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:05:40 INFO - Running post-action listener: _resource_record_post_action 13:05:40 INFO - ##### 13:05:40 INFO - ##### Finished clobber step (success) 13:05:40 INFO - ##### 13:05:40 INFO - ##### 13:05:40 INFO - ##### Running read-buildbot-config step. 13:05:40 INFO - ##### 13:05:40 INFO - Running pre-action listener: _resource_record_pre_action 13:05:40 INFO - Running main action method: read_buildbot_config 13:05:40 INFO - Using buildbot properties: 13:05:40 INFO - { 13:05:40 INFO - "project": "", 13:05:40 INFO - "product": "firefox", 13:05:40 INFO - "script_repo_revision": "production", 13:05:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:05:40 INFO - "repository": "", 13:05:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:05:40 INFO - "buildid": "20160715063123", 13:05:40 INFO - "pgo_build": "True", 13:05:40 INFO - "basedir": "/builds/slave/test", 13:05:40 INFO - "buildnumber": 290, 13:05:40 INFO - "slavename": "talos-linux64-ix-056", 13:05:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:05:40 INFO - "platform": "ubuntu64_hw", 13:05:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:05:40 INFO - "branch": "fx-team", 13:05:40 INFO - "repo_path": "integration/fx-team", 13:05:40 INFO - "revision": "b6e311c419b5f15680b3fa56fd197c0e93dc40a5", 13:05:40 INFO - "stage_platform": "linux64-pgo", 13:05:40 INFO - "builduid": "8a4f06db217c4baab5c78d71b9d8350b", 13:05:40 INFO - "slavebuilddir": "test" 13:05:40 INFO - } 13:05:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:05:40 INFO - Running post-action listener: _resource_record_post_action 13:05:40 INFO - ##### 13:05:40 INFO - ##### Finished read-buildbot-config step (success) 13:05:40 INFO - ##### 13:05:40 INFO - ##### 13:05:40 INFO - ##### Running download-and-extract step. 13:05:40 INFO - ##### 13:05:40 INFO - Running pre-action listener: _resource_record_pre_action 13:05:40 INFO - Running main action method: download_and_extract 13:05:40 INFO - mkdir: /builds/slave/test/build/tests 13:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:40 INFO - https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:05:41 INFO - Downloaded 1361 bytes. 13:05:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:05:41 INFO - Using the following test package requirements: 13:05:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:05:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:05:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:05:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'jsshell-linux-x86_64.zip'], 13:05:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:05:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:05:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:05:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:05:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:05:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:05:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:41 INFO - https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:05:43 INFO - Downloaded 24326850 bytes. 13:05:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:05:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:05:44 INFO - Return code: 0 13:05:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:44 INFO - https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:05:47 INFO - Downloaded 24326850 bytes. 13:05:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:05:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:05:48 INFO - Return code: 0 13:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:48 INFO - https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:05:49 INFO - Downloaded 14403317 bytes. 13:05:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:05:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:05:49 INFO - Return code: 0 13:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:49 INFO - https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:05:51 INFO - Downloaded 60811600 bytes. 13:05:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:51 INFO - mkdir: /builds/slave/test/properties 13:05:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:05:51 INFO - Writing to file /builds/slave/test/properties/build_url 13:05:51 INFO - Contents: 13:05:51 INFO - build_url:https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:52 INFO - Running post-action listener: _resource_record_post_action 13:05:52 INFO - Running post-action listener: set_extra_try_arguments 13:05:52 INFO - ##### 13:05:52 INFO - ##### Finished download-and-extract step (success) 13:05:52 INFO - ##### 13:05:52 INFO - ##### 13:05:52 INFO - ##### Running populate-webroot step. 13:05:52 INFO - ##### 13:05:52 INFO - Running pre-action listener: _resource_record_pre_action 13:05:52 INFO - Running main action method: populate_webroot 13:05:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:05:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:05:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:05:52 INFO - '--tppagecycles', 13:05:52 INFO - '7'], 13:05:52 INFO - 'tests': ['tsvgm']}}, 13:05:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:05:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:05:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:05:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['damp', 'tps']}, 13:05:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'tests': ['damp', 'tps']}, 13:05:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['dromaeo_dom']}, 13:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:05:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['basic_compositor_video']}, 13:05:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:05:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['a11yr', 13:05:52 INFO - 'ts_paint', 13:05:52 INFO - 'tpaint', 13:05:52 INFO - 'sessionrestore', 13:05:52 INFO - 'sessionrestore_no_auto_restore', 13:05:52 INFO - 'tabpaint']}, 13:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 13:05:52 INFO - 'ts_paint', 13:05:52 INFO - 'tpaint', 13:05:52 INFO - 'sessionrestore', 13:05:52 INFO - 'sessionrestore_no_auto_restore', 13:05:52 INFO - 'tabpaint']}, 13:05:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:05:52 INFO - 'ts_paint', 13:05:52 INFO - 'tpaint', 13:05:52 INFO - 'sessionrestore', 13:05:52 INFO - 'sessionrestore_no_auto_restore', 13:05:52 INFO - 'tabpaint']}, 13:05:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:05:52 INFO - 'ts_paint', 13:05:52 INFO - 'tpaint', 13:05:52 INFO - 'sessionrestore', 13:05:52 INFO - 'sessionrestore_no_auto_restore', 13:05:52 INFO - 'tabpaint']}, 13:05:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['a11yr', 13:05:52 INFO - 'ts_paint', 13:05:52 INFO - 'tpaint', 13:05:52 INFO - 'sessionrestore', 13:05:52 INFO - 'sessionrestore_no_auto_restore', 13:05:52 INFO - 'tabpaint']}, 13:05:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['a11yr', 13:05:52 INFO - 'ts_paint', 13:05:52 INFO - 'tpaint', 13:05:52 INFO - 'sessionrestore', 13:05:52 INFO - 'sessionrestore_no_auto_restore', 13:05:52 INFO - 'tabpaint']}, 13:05:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['tsvgx', 13:05:52 INFO - 'tsvgr_opacity', 13:05:52 INFO - 'tart', 13:05:52 INFO - 'tscrollx', 13:05:52 INFO - 'cart']}, 13:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:05:52 INFO - 'tsvgr_opacity', 13:05:52 INFO - 'tart', 13:05:52 INFO - 'tscrollx', 13:05:52 INFO - 'cart']}, 13:05:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'talos_options': ['--disable-e10s'], 13:05:52 INFO - 'tests': ['tp5o']}, 13:05:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'tests': ['tp5o']}, 13:05:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'talos_options': ['--disable-e10s', 13:05:52 INFO - '--xperf_path', 13:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:52 INFO - 'tests': ['tp5n']}, 13:05:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:52 INFO - 'talos_options': ['--xperf_path', 13:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:52 INFO - 'tests': ['tp5n']}}, 13:05:52 INFO - 'talos.zip': {'path': '', 13:05:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:05:52 INFO - Running post-action listener: _resource_record_post_action 13:05:52 INFO - ##### 13:05:52 INFO - ##### Finished populate-webroot step (success) 13:05:52 INFO - ##### 13:05:52 INFO - ##### 13:05:52 INFO - ##### Running create-virtualenv step. 13:05:52 INFO - ##### 13:05:52 INFO - Running pre-action listener: _resource_record_pre_action 13:05:52 INFO - Running main action method: create_virtualenv 13:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 13:05:52 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 13:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:05:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:05:52 INFO - Using real prefix '/usr' 13:05:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:05:52 INFO - Installing distribute.............................................................................................................................................................................................done. 13:05:54 INFO - Installing pip.................done. 13:05:54 INFO - Return code: 0 13:05:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:05:54 INFO - Using env: {'DISPLAY': ':0', 13:05:54 INFO - 'HOME': '/home/cltbld', 13:05:54 INFO - 'LANG': 'en_US.UTF-8', 13:05:54 INFO - 'LANGUAGE': 'en_US:en', 13:05:54 INFO - 'LOGNAME': 'cltbld', 13:05:54 INFO - 'MAIL': '/var/mail/cltbld', 13:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:54 INFO - 'MOZ_NO_REMOTE': '1', 13:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:54 INFO - 'NO_EM_RESTART': '1', 13:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:54 INFO - 'PWD': '/builds/slave/test', 13:05:54 INFO - 'SHELL': '/bin/bash', 13:05:54 INFO - 'SHLVL': '1', 13:05:54 INFO - 'TERM': 'linux', 13:05:54 INFO - 'TMOUT': '86400', 13:05:54 INFO - 'USER': 'cltbld', 13:05:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:54 INFO - '_': '/tools/buildbot/bin/python'} 13:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:55 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 13:05:55 INFO - Cleaning up... 13:05:55 INFO - Return code: 0 13:05:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:55 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:05:55 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 13:05:55 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 13:05:55 INFO - Using env: {'DISPLAY': ':0', 13:05:55 INFO - 'HOME': '/home/cltbld', 13:05:55 INFO - 'LANG': 'en_US.UTF-8', 13:05:55 INFO - 'LANGUAGE': 'en_US:en', 13:05:55 INFO - 'LOGNAME': 'cltbld', 13:05:55 INFO - 'MAIL': '/var/mail/cltbld', 13:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:55 INFO - 'MOZ_NO_REMOTE': '1', 13:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:55 INFO - 'NO_EM_RESTART': '1', 13:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:55 INFO - 'PWD': '/builds/slave/test', 13:05:55 INFO - 'SHELL': '/bin/bash', 13:05:55 INFO - 'SHLVL': '1', 13:05:55 INFO - 'TERM': 'linux', 13:05:55 INFO - 'TMOUT': '86400', 13:05:55 INFO - 'USER': 'cltbld', 13:05:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:55 INFO - '_': '/tools/buildbot/bin/python'} 13:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:55 INFO - Downloading/unpacking psutil>=3.1.1 13:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:57 INFO - Installing collected packages: psutil 13:05:57 INFO - Running setup.py install for psutil 13:05:57 INFO - building 'psutil._psutil_linux' extension 13:05:57 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 13:05:57 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 13:05:57 INFO - building 'psutil._psutil_posix' extension 13:05:57 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 13:05:57 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 13:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:57 INFO - Successfully installed psutil 13:05:57 INFO - Cleaning up... 13:05:57 INFO - Return code: 0 13:05:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:57 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:05:57 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 13:05:57 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 13:05:57 INFO - Using env: {'DISPLAY': ':0', 13:05:57 INFO - 'HOME': '/home/cltbld', 13:05:57 INFO - 'LANG': 'en_US.UTF-8', 13:05:57 INFO - 'LANGUAGE': 'en_US:en', 13:05:57 INFO - 'LOGNAME': 'cltbld', 13:05:57 INFO - 'MAIL': '/var/mail/cltbld', 13:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:57 INFO - 'MOZ_NO_REMOTE': '1', 13:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:57 INFO - 'NO_EM_RESTART': '1', 13:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:57 INFO - 'PWD': '/builds/slave/test', 13:05:57 INFO - 'SHELL': '/bin/bash', 13:05:57 INFO - 'SHLVL': '1', 13:05:57 INFO - 'TERM': 'linux', 13:05:57 INFO - 'TMOUT': '86400', 13:05:57 INFO - 'USER': 'cltbld', 13:05:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:57 INFO - '_': '/tools/buildbot/bin/python'} 13:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:05:58 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 13:05:58 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 13:05:58 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 13:05:58 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 13:05:58 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 13:05:58 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 13:06:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:06:00 INFO - Installing collected packages: mozsystemmonitor 13:06:00 INFO - Running setup.py install for mozsystemmonitor 13:06:00 INFO - Successfully installed mozsystemmonitor 13:06:00 INFO - Cleaning up... 13:06:00 INFO - Return code: 0 13:06:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:00 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:06:00 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 13:06:00 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 13:06:00 INFO - Using env: {'DISPLAY': ':0', 13:06:00 INFO - 'HOME': '/home/cltbld', 13:06:00 INFO - 'LANG': 'en_US.UTF-8', 13:06:00 INFO - 'LANGUAGE': 'en_US:en', 13:06:00 INFO - 'LOGNAME': 'cltbld', 13:06:00 INFO - 'MAIL': '/var/mail/cltbld', 13:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:00 INFO - 'MOZ_NO_REMOTE': '1', 13:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:00 INFO - 'NO_EM_RESTART': '1', 13:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:00 INFO - 'PWD': '/builds/slave/test', 13:06:00 INFO - 'SHELL': '/bin/bash', 13:06:00 INFO - 'SHLVL': '1', 13:06:00 INFO - 'TERM': 'linux', 13:06:00 INFO - 'TMOUT': '86400', 13:06:00 INFO - 'USER': 'cltbld', 13:06:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:00 INFO - '_': '/tools/buildbot/bin/python'} 13:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:00 INFO - Downloading/unpacking jsonschema==2.5.1 13:06:00 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 13:06:00 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 13:06:00 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 13:06:00 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 13:06:00 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 13:06:00 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 13:06:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:06:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:02 INFO - Downloading functools32-3.2.3-2.tar.gz 13:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:06:02 INFO - warning: no files found matching '*.txt' 13:06:02 INFO - no previously-included directories found matching 'build' 13:06:02 INFO - no previously-included directories found matching 'dist' 13:06:02 INFO - no previously-included directories found matching '.git*' 13:06:02 INFO - Installing collected packages: jsonschema, functools32 13:06:02 INFO - Running setup.py install for functools32 13:06:02 INFO - warning: no files found matching '*.txt' 13:06:02 INFO - no previously-included directories found matching 'build' 13:06:02 INFO - no previously-included directories found matching 'dist' 13:06:02 INFO - no previously-included directories found matching '.git*' 13:06:02 INFO - Successfully installed jsonschema functools32 13:06:02 INFO - Cleaning up... 13:06:02 INFO - Return code: 0 13:06:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:02 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:06:02 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 13:06:02 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 13:06:02 INFO - Using env: {'DISPLAY': ':0', 13:06:02 INFO - 'HOME': '/home/cltbld', 13:06:02 INFO - 'LANG': 'en_US.UTF-8', 13:06:02 INFO - 'LANGUAGE': 'en_US:en', 13:06:02 INFO - 'LOGNAME': 'cltbld', 13:06:02 INFO - 'MAIL': '/var/mail/cltbld', 13:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:02 INFO - 'MOZ_NO_REMOTE': '1', 13:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:02 INFO - 'NO_EM_RESTART': '1', 13:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:02 INFO - 'PWD': '/builds/slave/test', 13:06:02 INFO - 'SHELL': '/bin/bash', 13:06:02 INFO - 'SHLVL': '1', 13:06:02 INFO - 'TERM': 'linux', 13:06:02 INFO - 'TMOUT': '86400', 13:06:02 INFO - 'USER': 'cltbld', 13:06:02 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:02 INFO - '_': '/tools/buildbot/bin/python'} 13:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:03 INFO - Downloading/unpacking blobuploader==1.2.4 13:06: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 13:06: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 13:06: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 13:06: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 13:06: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 13:06: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 13:06:04 INFO - Downloading blobuploader-1.2.4.tar.gz 13:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:06:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:05 INFO - Downloading docopt-0.6.1.tar.gz 13:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:06:05 INFO - Installing collected packages: blobuploader, requests, docopt 13:06:05 INFO - Running setup.py install for blobuploader 13:06:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:06:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:06:05 INFO - Running setup.py install for requests 13:06:06 INFO - Running setup.py install for docopt 13:06:06 INFO - Successfully installed blobuploader requests docopt 13:06:06 INFO - Cleaning up... 13:06:06 INFO - Return code: 0 13:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:06 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:06:06 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 13:06:06 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 13:06:06 INFO - Using env: {'DISPLAY': ':0', 13:06:06 INFO - 'HOME': '/home/cltbld', 13:06:06 INFO - 'LANG': 'en_US.UTF-8', 13:06:06 INFO - 'LANGUAGE': 'en_US:en', 13:06:06 INFO - 'LOGNAME': 'cltbld', 13:06:06 INFO - 'MAIL': '/var/mail/cltbld', 13:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:06 INFO - 'MOZ_NO_REMOTE': '1', 13:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:06 INFO - 'NO_EM_RESTART': '1', 13:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:06 INFO - 'PWD': '/builds/slave/test', 13:06:06 INFO - 'SHELL': '/bin/bash', 13:06:06 INFO - 'SHLVL': '1', 13:06:06 INFO - 'TERM': 'linux', 13:06:06 INFO - 'TMOUT': '86400', 13:06:06 INFO - 'USER': 'cltbld', 13:06:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:06 INFO - '_': '/tools/buildbot/bin/python'} 13:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:06 INFO - Running setup.py (path:/tmp/pip-3f0JNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:06 INFO - Running setup.py (path:/tmp/pip-DPjgnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:06 INFO - Running setup.py (path:/tmp/pip-eXflpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:06 INFO - Running setup.py (path:/tmp/pip-4O8mVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:06 INFO - Running setup.py (path:/tmp/pip-_bdE5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:06 INFO - Running setup.py (path:/tmp/pip-cRxEvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:07 INFO - Running setup.py (path:/tmp/pip-OwY6gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:07 INFO - Running setup.py (path:/tmp/pip-SF0_9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:07 INFO - Running setup.py (path:/tmp/pip-XRQ2bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:07 INFO - Running setup.py (path:/tmp/pip-C0Cr7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:07 INFO - Running setup.py (path:/tmp/pip-0nR5pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:07 INFO - Running setup.py (path:/tmp/pip-CqT3MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:07 INFO - Running setup.py (path:/tmp/pip-k_fX4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:07 INFO - Running setup.py (path:/tmp/pip-zrEvKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:07 INFO - Running setup.py (path:/tmp/pip-zwjRtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:07 INFO - Running setup.py (path:/tmp/pip-T7Cflp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:07 INFO - Running setup.py (path:/tmp/pip-L8eC9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:06:07 INFO - Running setup.py install for manifestparser 13:06:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:06:07 INFO - Running setup.py install for mozcrash 13:06:08 INFO - Running setup.py install for mozdebug 13:06:08 INFO - Running setup.py install for mozdevice 13:06:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Running setup.py install for mozfile 13:06:08 INFO - Running setup.py install for mozhttpd 13:06:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Running setup.py install for mozinfo 13:06:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Running setup.py install for mozInstall 13:06:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Running setup.py install for mozleak 13:06:08 INFO - Running setup.py install for mozlog 13:06:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Running setup.py install for moznetwork 13:06:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:06:08 INFO - Running setup.py install for mozprocess 13:06:09 INFO - Running setup.py install for mozprofile 13:06:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:06:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:06:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:06:09 INFO - Running setup.py install for mozrunner 13:06:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:06:09 INFO - Running setup.py install for mozscreenshot 13:06:09 INFO - Running setup.py install for moztest 13:06:09 INFO - Running setup.py install for mozversion 13:06:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:06:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:06:09 INFO - Cleaning up... 13:06:09 INFO - Return code: 0 13:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:09 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:06:09 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 13:06:09 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 13:06:09 INFO - Using env: {'DISPLAY': ':0', 13:06:09 INFO - 'HOME': '/home/cltbld', 13:06:09 INFO - 'LANG': 'en_US.UTF-8', 13:06:09 INFO - 'LANGUAGE': 'en_US:en', 13:06:09 INFO - 'LOGNAME': 'cltbld', 13:06:09 INFO - 'MAIL': '/var/mail/cltbld', 13:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:09 INFO - 'MOZ_NO_REMOTE': '1', 13:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:09 INFO - 'NO_EM_RESTART': '1', 13:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:09 INFO - 'PWD': '/builds/slave/test', 13:06:09 INFO - 'SHELL': '/bin/bash', 13:06:09 INFO - 'SHLVL': '1', 13:06:09 INFO - 'TERM': 'linux', 13:06:09 INFO - 'TMOUT': '86400', 13:06:09 INFO - 'USER': 'cltbld', 13:06:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:09 INFO - '_': '/tools/buildbot/bin/python'} 13:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:09 INFO - Running setup.py (path:/tmp/pip-KIGido-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:09 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)) 13:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:09 INFO - Running setup.py (path:/tmp/pip-yWtOL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:10 INFO - Running setup.py (path:/tmp/pip-5ldwb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:10 INFO - Running setup.py (path:/tmp/pip-WV76_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:10 INFO - Running setup.py (path:/tmp/pip-H5m_2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:10 INFO - Running setup.py (path:/tmp/pip-ND9u7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:10 INFO - Running setup.py (path:/tmp/pip-j8STlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:10 INFO - Running setup.py (path:/tmp/pip-ya5Eld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:10 INFO - Running setup.py (path:/tmp/pip-Fbb5xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:10 INFO - Running setup.py (path:/tmp/pip-k8_AnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:10 INFO - Running setup.py (path:/tmp/pip-7Mq0Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:10 INFO - Running setup.py (path:/tmp/pip-iTSEA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:10 INFO - Running setup.py (path:/tmp/pip-gQsI81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:10 INFO - Running setup.py (path:/tmp/pip-SMKtYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:10 INFO - Running setup.py (path:/tmp/pip-UysQyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:10 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)) 13:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:10 INFO - Running setup.py (path:/tmp/pip-EnXERj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:11 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)) 13:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:11 INFO - Running setup.py (path:/tmp/pip-5POQ5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:11 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)) 13:06:11 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)) 13:06:11 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)) 13:06:11 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)) 13:06:11 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)) 13:06:11 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)) 13:06:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:06: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 13:06: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 13:06: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 13:06: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 13:06: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 13:06: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 13:06:13 INFO - Downloading blessings-1.6.tar.gz 13:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:06:13 INFO - Installing collected packages: blessings 13:06:13 INFO - Running setup.py install for blessings 13:06:13 INFO - Successfully installed blessings 13:06:13 INFO - Cleaning up... 13:06:13 INFO - Return code: 0 13:06:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:13 INFO - Reading from file tmpfile_stdout 13:06:13 INFO - Current package versions: 13:06:13 INFO - argparse == 1.2.1 13:06:13 INFO - blessings == 1.6 13:06:13 INFO - blobuploader == 1.2.4 13:06:13 INFO - docopt == 0.6.1 13:06:13 INFO - functools32 == 3.2.3-2 13:06:13 INFO - jsonschema == 2.5.1 13:06:13 INFO - manifestparser == 1.1 13:06:13 INFO - mozInstall == 1.12 13:06:13 INFO - mozcrash == 0.17 13:06:13 INFO - mozdebug == 0.1 13:06:13 INFO - mozdevice == 0.48 13:06:13 INFO - mozfile == 1.2 13:06:13 INFO - mozhttpd == 0.7 13:06:13 INFO - mozinfo == 0.9 13:06:13 INFO - mozleak == 0.1 13:06:13 INFO - mozlog == 3.2 13:06:13 INFO - moznetwork == 0.27 13:06:13 INFO - mozprocess == 0.23 13:06:13 INFO - mozprofile == 0.28 13:06:13 INFO - mozrunner == 6.12 13:06:13 INFO - mozscreenshot == 0.1 13:06:13 INFO - mozsystemmonitor == 0.3 13:06:13 INFO - moztest == 0.7 13:06:13 INFO - mozversion == 1.4 13:06:13 INFO - psutil == 3.1.1 13:06:13 INFO - requests == 1.2.3 13:06:13 INFO - wsgiref == 0.1.2 13:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:13 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:06:13 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 13:06:13 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 13:06:13 INFO - Using env: {'DISPLAY': ':0', 13:06:13 INFO - 'HOME': '/home/cltbld', 13:06:13 INFO - 'LANG': 'en_US.UTF-8', 13:06:13 INFO - 'LANGUAGE': 'en_US:en', 13:06:13 INFO - 'LOGNAME': 'cltbld', 13:06:13 INFO - 'MAIL': '/var/mail/cltbld', 13:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:13 INFO - 'MOZ_NO_REMOTE': '1', 13:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:13 INFO - 'NO_EM_RESTART': '1', 13:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:13 INFO - 'PWD': '/builds/slave/test', 13:06:13 INFO - 'SHELL': '/bin/bash', 13:06:13 INFO - 'SHLVL': '1', 13:06:13 INFO - 'TERM': 'linux', 13:06:13 INFO - 'TMOUT': '86400', 13:06:13 INFO - 'USER': 'cltbld', 13:06:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:13 INFO - '_': '/tools/buildbot/bin/python'} 13:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 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)) 13:06:13 INFO - Cleaning up... 13:06:13 INFO - Return code: 0 13:06:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:13 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 0x16b8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1979180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, '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': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', '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 13:06:13 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 13:06:13 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 13:06:13 INFO - Using env: {'DISPLAY': ':0', 13:06:13 INFO - 'HOME': '/home/cltbld', 13:06:13 INFO - 'LANG': 'en_US.UTF-8', 13:06:13 INFO - 'LANGUAGE': 'en_US:en', 13:06:13 INFO - 'LOGNAME': 'cltbld', 13:06:13 INFO - 'MAIL': '/var/mail/cltbld', 13:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:13 INFO - 'MOZ_NO_REMOTE': '1', 13:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:13 INFO - 'NO_EM_RESTART': '1', 13:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:13 INFO - 'PWD': '/builds/slave/test', 13:06:13 INFO - 'SHELL': '/bin/bash', 13:06:13 INFO - 'SHLVL': '1', 13:06:13 INFO - 'TERM': 'linux', 13:06:13 INFO - 'TMOUT': '86400', 13:06:13 INFO - 'USER': 'cltbld', 13:06:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:13 INFO - '_': '/tools/buildbot/bin/python'} 13:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:06:13 INFO - Cleaning up... 13:06:13 INFO - Return code: 0 13:06:13 INFO - Running post-action listener: _resource_record_post_action 13:06:13 INFO - Running post-action listener: _start_resource_monitoring 13:06:14 INFO - Starting resource monitoring. 13:06:14 INFO - ##### 13:06:14 INFO - ##### Finished create-virtualenv step (success) 13:06:14 INFO - ##### 13:06:14 INFO - ##### 13:06:14 INFO - ##### Running install step. 13:06:14 INFO - ##### 13:06:14 INFO - Running pre-action listener: _resource_record_pre_action 13:06:14 INFO - Running main action method: install 13:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:14 INFO - Reading from file tmpfile_stdout 13:06:14 INFO - Detecting whether we're running mozinstall >=1.0... 13:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:06:14 INFO - Reading from file tmpfile_stdout 13:06:14 INFO - Output received: 13:06:14 INFO - Usage: mozinstall [options] installer 13:06:14 INFO - Options: 13:06:14 INFO - -h, --help show this help message and exit 13:06:14 INFO - -d DEST, --destination=DEST 13:06:14 INFO - Directory to install application into. [default: 13:06:14 INFO - "/builds/slave/test"] 13:06:14 INFO - --app=APP Application being installed. [default: firefox] 13:06:14 INFO - mkdir: /builds/slave/test/build/application 13:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:06:31 INFO - Reading from file tmpfile_stdout 13:06:31 INFO - Output received: 13:06:31 INFO - /builds/slave/test/build/application/firefox/firefox 13:06:31 INFO - Running post-action listener: _resource_record_post_action 13:06:31 INFO - ##### 13:06:31 INFO - ##### Finished install step (success) 13:06:31 INFO - ##### 13:06:31 INFO - ##### 13:06:31 INFO - ##### Running run-tests step. 13:06:31 INFO - ##### 13:06:31 INFO - Running pre-action listener: _resource_record_pre_action 13:06:31 INFO - Running main action method: run_tests 13:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:06:31 INFO - Python 2.7.3 13:06:31 INFO - Return code: 0 13:06:31 INFO - grabbing minidump binary from tooltool 13:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:31 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 0x19773b0>, '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 0x19782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1978740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:06:31 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 13:06:31 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 13:06:31 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 13:06:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:06:31 INFO - Return code: 0 13:06:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:06:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:06:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:06:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:06:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:06:31 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/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 13:06:31 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/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 13:06:31 INFO - Using env: {'DISPLAY': ':0', 13:06:31 INFO - 'HOME': '/home/cltbld', 13:06:31 INFO - 'LANG': 'en_US.UTF-8', 13:06:31 INFO - 'LANGUAGE': 'en_US:en', 13:06:31 INFO - 'LOGNAME': 'cltbld', 13:06:31 INFO - 'MAIL': '/var/mail/cltbld', 13:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:31 INFO - 'MOZ_NO_REMOTE': '1', 13:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:31 INFO - 'NO_EM_RESTART': '1', 13:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:31 INFO - 'PWD': '/builds/slave/test', 13:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:06:31 INFO - 'SHELL': '/bin/bash', 13:06:31 INFO - 'SHLVL': '1', 13:06:31 INFO - 'TERM': 'linux', 13:06:31 INFO - 'TMOUT': '86400', 13:06:31 INFO - 'USER': 'cltbld', 13:06:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468613136.694900-96965533', 13:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:31 INFO - '_': '/tools/buildbot/bin/python'} 13:06:31 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/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 13:06:31 INFO - mozversion application_buildid: 20160715063123 13:06:31 INFO - mozversion application_changeset: b6e311c419b5f15680b3fa56fd197c0e93dc40a5 13:06:31 INFO - mozversion application_display_name: Nightly 13:06:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:06:31 INFO - mozversion application_name: Firefox 13:06:31 INFO - mozversion application_remotingname: firefox 13:06:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:06:31 INFO - mozversion application_vendor: Mozilla 13:06:31 INFO - mozversion application_version: 50.0a1 13:06:31 INFO - mozversion platform_buildid: 20160715063123 13:06:31 INFO - mozversion platform_changeset: b6e311c419b5f15680b3fa56fd197c0e93dc40a5 13:06:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:06:31 INFO - mozversion platform_version: 50.0a1 13:06:31 INFO - using testdate: 1468613191 13:06:31 INFO - actual date: 1468613191 13:06:31 INFO - starting webserver on 'localhost:52719' 13:06:31 INFO - SUITE-START | Running 2 tests 13:06:31 INFO - TEST-START | dromaeo_css 13:06:31 INFO - operating with platform_type : linux_ 13:06:31 INFO - Initialising browser for dromaeo_css test... 13:06:31 INFO - TEST-INFO | started process 13693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLsZfqc/profile http://localhost:52719/getInfo.html) 13:06:35 INFO - PROCESS | 13693 | __metrics Screen width/height:1600/1200 13:06:35 INFO - PROCESS | 13693 | colorDepth:24 13:06:35 INFO - PROCESS | 13693 | Browser inner width/height: 1024/697 13:06:35 INFO - PROCESS | 13693 | __metrics 13:06:36 INFO - PROCESS | 13693 | 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" 13:06:36 INFO - PROCESS | 13693 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:06:37 INFO - TEST-INFO | 13693: exit 0 13:06:37 INFO - Browser initialized. 13:06:37 INFO - Running cycle 1/1 for dromaeo_css test... 13:06:37 INFO - TEST-INFO | started process 13779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLsZfqc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:06:49 INFO - PROCESS | 13779 | RSS: Main: 157618176 13:06:49 INFO - PROCESS | 13779 | 13:07:41 INFO - PROCESS | 13779 | 1468613261116 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] 13:09:48 INFO - PROCESS | 13779 | Cycle 1(1): loaded http://localhost:52719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52719/tests/dromaeo/cssquery-ext.html) 13:09:49 INFO - PROCESS | 13779 | RSS: Main: 246202368 13:09:49 INFO - PROCESS | 13779 | 13:12:52 INFO - PROCESS | 13779 | Cycle 1(1): loaded http://localhost:52719/tests/dromaeo/cssquery-ext.html (next: http://localhost:52719/tests/dromaeo/cssquery-jquery.html) 13:12:52 INFO - PROCESS | 13779 | RSS: Main: 251117568 13:12:52 INFO - PROCESS | 13779 | 13:15:54 INFO - PROCESS | 13779 | Cycle 1(1): loaded http://localhost:52719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52719/tests/dromaeo/cssquery-mootools.html) 13:15:55 INFO - PROCESS | 13779 | RSS: Main: 247984128 13:15:55 INFO - PROCESS | 13779 | 13:18:57 INFO - PROCESS | 13779 | Cycle 1(1): loaded http://localhost:52719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52719/tests/dromaeo/cssquery-prototype.html) 13:18:58 INFO - PROCESS | 13779 | RSS: Main: 247902208 13:18:58 INFO - PROCESS | 13779 | 13:22:00 INFO - PROCESS | 13779 | Cycle 1(1): loaded http://localhost:52719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52719/tests/dromaeo/cssquery-yui.html) 13:22:01 INFO - PROCESS | 13779 | RSS: Main: 233144320 13:22:01 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | Cycle 1(1): loaded http://localhost:52719/tests/dromaeo/cssquery-yui.html (next: http://localhost:52719/tests/dromaeo/cssquery-dojo.html) 13:25:04 INFO - PROCESS | 13779 | RSS: Main: 280272896 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | __start_tp_report 13:25:04 INFO - PROCESS | 13779 | _x_x_mozilla_page_load 13:25:04 INFO - PROCESS | 13779 | _x_x_mozilla_page_load_details 13:25:04 INFO - PROCESS | 13779 | |i|pagename|runs| 13:25:04 INFO - PROCESS | 13779 | |0;dojo.html;3047.3143542702896;3069.6623371429155;3091.010876519513;3108.9844550777248;3116.25209949612;5232.529072383485;5328.520433161015;5352.0098781725355;5422.3493180818305;5458.645188062773;5161.741912904358;5165.9668066386685;5239.842804715865;5308.044551980642;5335.466453354663;4631.652626053043;4689.601383882374;4707.411573553306;4764.142454358214;4968.776405061781;4890.290907818364;4938.234573641073;4940.1601727706375;4953.4798846121175;4956.2070068789;4775.689580177294;4777.641676874248;4856.320115183859;4857.757112144379;4863.343448634424;4786.64100192487;4791.520847915215;4800.687955282895;4809.975950120262;4904.901901961976;4795.2807078938085;4834.975825120887;4835.830745923911;4841.515848415165;4870.196417591129;5223.582113430916;5281.471852814726;5330.227117068003;5357.598180136466;5382.2464854920345;5784.07454807233;5828.242328497268;5850.97074514629;5857.824265272006;5858.209141765849;5863.061910094407;5871.823845284648;5873.236479257712;5890.587658863881;5895.380984996556;5207.947920520822;5317.042932272189;5366.70483123428;5388.299521062276;5477.3427188737605;5964.045752679551;5964.552658550626;5965.135055417027;5977.551683623746;5980.0132978059;5473.480019398151;5712.885742285131;5733.541316694655;5746.741396637161;5747.741351639186;5632.183333416631;5683.7442315095095;5693.5160511357;5738.885222295531;5739.110437882135;5723.7996670116345;5730.5129064030025;5733.655980641091;5736.225609542658;5736.741846616829;5539.584531160179;5646.350669672958;5724.914126288109;5737.5983681141915;5737.799177028867;4377.671674624416;4394.538573449806;4394.8242070317465;4438.489573699066;4448.888777780517;3889.144388234584;3914.099757055893;3922.1371298314325;3924.0778417071965;3946.960530394717;5268.78924843002;5329.840104796862;5410.323709536308;5436.592255580847;5521.889562208814;5740.913886291709;5796;5798.188253644493;5806.9419305806405;5850.063989761703;5467.890642187134;5472.26124473199;5477.096279113981;5478.013957487611;5483.890322193613;4887.853364399074;4892.510748925079;4897.877553061202;4995.600351971833;5053.9747301264;5944.167816505693;5949.583529152917;5953.464188223081;5955.493783028491;5988.610740301867;5751.568632352507;5757.971210143923;5769.94230057694;5773.162891380643;5775.33583637887;5641.576881733804;5751.194832723339;5782.624129431573;5806.4483874033585;5920.733566989582;5555.2778138841695;5568.777248909998;5569.275994120739;5628.971855140698;5650.3219613646625;5704.229928959538;5733.684647344436;5745.856353591026;5747.367789543064;5753.510951569164;5404.567634589145;5552.056150454513;5558.805441809517;5606.915896261641;5642;5627.352854421794;5633.88732225345;5634.098544232903;5634.971825141012;5640.661560306395;5372.758225879923;5526.50261476469;5530.198121272312;5559.888802223852;5584.0227960106;5527.281453411031;5563.1655251710945;5571.7492712828835;5612.579056570855;5669.433056694463;5493.956148331804;5494.862628434161;5498.147787093007;5505.614606977473;5511.200875873056 13:25:04 INFO - PROCESS | 13779 | |1;ext.html;616.67932675009;634.9111124442577;653.9901901471479;654.9476041916647;664.6477366995495;32004;34683.47974780377;43152.136957260875;44642.776786116025;45263.77368113155;45905;46210.53789462104;46225.30662040072;46273.30590041152;46305;8898.33262505313;9034.728958131267;9046.909530904673;9049.095090490931;9063.864042039375;8968.327375446836;8993.190612844843;9018.05310442404;9074.319426043041;9077.818443631124;8980.955095224515;9039;9040.276777857756;9088.681896133636;9165.266778657691;8979.057198994142;9007.504587247699;9037.367384283103;9048;9048.864267036033;8877.556122193864;8936.687215947475;8963.865542016874;8969.14793094655;9046.231070359026;44465.55534444647;44611.77694111509;44697.77651111756;44710.32934505985;44788.77605611984;3516.1209697575605;3536.416491278936;3710.666040056408;3775.7923314217705;4421.159979603897;33997.660023399694;34048.82975585131;34635;34723.82638086793;34827.825860870784;4488.932666010012;4511.187986162489;4519.254323036695;4582.6104781093645;4702.3416721659;376023;377529.1123544392;379038;379186;380406;63588;63859.6807015962;64061.35938640554;64386.356136438975;64395.356046439876;67544.66227668928;67586.66206668936;67959.3204067953;67990;68157.3184268151;16808.243629036722;16981.745273820903;16992.74510882338;17005.319787208373;17009.574760631083;12865.742685146244;12936.417861196269;12954.740905181843;12980.67548311281;12992;18002.635148603928;20181.192752290037;20204.595908081756;20325.390238292875;20347.186112555628;7288.489805713655;7300.306470885257;7310.733672561417;7405.259474052659;7495.437842161859;736.5213678531197;1077.6766969909152;1133.002957397485;1142.845715828369;1158.1834806461425;36331.4550281746;37244;37430.251394972496;37732.43401348982;37828.62171378306;1110.5779803674714;1163.4531770068224;1200.8438902942562;1211.1340391620033;1228.3980849383915;17161;17638.470845874643;17879.37422190243;17899.10504474771;17968.1015949202;582854;583067;589763;590517;592038;61865.38134618686;63447.6827615859;63485;63588.36411635917;63758.36241637617;1268.7272236469203;1351.398627610704;1392.8258967629047;1415.8903234181203;1435.9210243436503;32849.50725739163;35369.46945795764;35477.645223547435;35499;35711;53557.73221133869;53598.73200633972;54220.45779542312;54435.45564544304;54471;412864;421167;421232;422172;422555;21165.365039048855;46765.53234467748;47067;47964.5203547974;49523.25715114204;49272;49715.502844972536;52330.47669523256;53530.464695352544;53955.22313438022;43038;44992;45677.54322456866;46747.29879051749;47151;44108.779456102515;44612.10775784531;45145.77427112844;46002;46540.30189547227;43947.34078988882;45250;45622;45655.543444565126;45687.54312456833;38754.80622596982;39707.60292397039;39911;40229;40606.79696601498;29360.853195733886;29470.852645736635;29812.403751924405;30178.396432071673;30319 13:25:04 INFO - PROCESS | 13779 | |2;jquery.html;394.68425259792195;397.7931475632671;398.3168865395846;399.5525011986575;416.65209550025725;13082.553963931952;18993.620127597438;20567;20625.587488250225;20650.967451627414;14912;19712.40862774119;19802.504937376572;20339.28812491563;20649.793502064975;5740.655560666363;5903.026000709878;5908.379620139888;5909.556783241253;5944.583879128462;5192.428832828386;5217.139172036628;5221.947780522184;5226.163813789775;5234.659747116444;4202.2856114460465;6136.171616831715;6440.806775796734;6450.8064758057335;6545.639989800559;6233.283172435137;6442.194725659293;6499.057636642684;6512.5766825156215;6537.313582073885;5657.971710141464;5662.915056274159;5668.178114173422;5696.401877802812;5699.059655156894;23269.418264543354;23780.643290350657;24572.877135614388;24576.877115614487;24971.250862474153;2374.8812559371963;2412.986545650831;2526.0401047601977;2794.3712664650493;3138.10563989262;14887.330070146761;15178.089314641156;15197.468088616955;15262.38950441981;15289;1897.5635603811063;1922.1926790747918;1985.434151266882;1986.145957238387;2018.5660083082207;79342;81086.59456702738;81464;85254.14745852524;85481;10443.94778026105;10564.207684423698;10816.513256903458;10832.675019749262;10907;14917.40330386794;14949.476768313058;15018.549443516711;15043.323050462755;15079.24603769807;8083.544961906913;8084.919150808417;8179.304759095544;8249.958750206211;8382.83234335322;8005.919940800517;8043.597820109088;8044.839103217902;8086.716964906318;8154.8776768348525;5986.760529578855;6219.626822390581;6246.375362463808;6545.116409284781;6849.931500684929;1739.7303417969981;1881.1158755384947;1937.5059359863426;1939.4084804134875;1947.1140631012854;919.1314208073306;929.8047410043831;939.4973689076311;969.6121551379505;974.2060220919927;18291.84335245697;19134.71297930532;19165;19190.328338508087;19463.513412164808;979.5298256836759;992.1864071461476;1013.4375421640913;1015.2588610314511;1044.6970378590124;10430.26988110825;10729.577618168452;10785.56857725698;10870.782584348426;10881.292715973595;480637;489166;491946;493322;494802;83551.5822420884;84561;85758.5712071448;87300.56349718338;87897;989.2135752076972;1015.7155996321042;1033.3231733214907;1040.1314902056715;1047.6909311753052;15608.375664973273;16927.15364231808;16976.06631635272;17064.65870682604;17273.222704978056;41857.581424185366;41954.79022604867;42334.941626459586;43007.354889676055;43093.35359969666;52690.736546318556;53353;54228.457715422344;54324.728376359446;54984.725076374365;8563.486190828571;8802.119788021148;8860.246879015356;8880.86678699807;8881.067487913677;13541.86458135406;13590.184588924696;13834.23911684867;13905.16569005863;13968.720625587635;11673.12451566119;11721.300411440123;11762.294262344287;11872.940635296769;12168.391580421121;11808.114391420506;11934.522619095485;12045.75908481843;12073.57742479009;12297.815532767194;11827.526898923947;11934.880651193376;11987.561492620942;12088.39558022113;12215.938920305342;8573.142685731627;8629.39594228423;8754.60604272822;8756.343274254585;8977.23693486061;11253.549858005588;11975.940120299343;12308.323042232763;12439.813402798783;12690.175138615961 13:25:04 INFO - PROCESS | 13779 | |3;mootools.html;1313.6715821044738;1478.1057460236557;1493.5668656089733;1638.5821615488048;1780.3056807844935;8665.69670061548;9064.320175986802;9069.365144439891;9307.441553506778;9320.90679093209;9071.455712657245;9267.582958766854;9268.72193834186;9273.350865439423;9277.582508787104;2079.1995081893506;2145.7639659637425;2146.957060858782;2410.855348679076;2442.6213936839818;2063.3397312859893;2072.492239401349;2338.181636427254;2400.2799160251943;2419.1049311754678;2405.2062819269686;2407.193590147294;2440.023990403835;2441.1944058460667;2442.157455677788;2031.4311992642083;2366.420227044368;2375.5248950210025;2376.8930398132125;2380.262118743195;2144.5925274197853;2206.0403724379944;2208.1277895231456;2217.1242359268;2223.466368071667;9328.533573321307;9372.39079459833;9398.201152902011;9401.905980940172;9423.764405889839;5413.296271484721;5550.333959924795;5554;5554.638948468337;5556.722163891789;3419.145213696576;3500.264944361687;3572.1069732566857;3590.569131704186;3608.657177568127;1181.1908842442954;1224.5714000099983;1229.1088960503564;1244.9439775210137;1259.4710221706905;13038.217706937614;13042.282674452901;13049.86950130496;13052.086353955227;13058.477660893554;4717.787699553528;4766.217426849646;4833.32333473314;4896.877578060577;4944.060628480577;10868.402237876835;10873.347599144077;10881.782364352668;10886.074683651977;10892.61875834342;5546.473085056913;5551.417101204396;5556.16657501378;5563.332400111932;5574.554035677136;5001.674891132065;5131.974340128276;5136.5890728741615;5137.51193636604;5162.896742065138;4114.670826333886;4139.379093135994;4179;4219.219444402734;4228.556001619847;1286.273255610577;1314.5464814638933;1330.6673331667084;1338.919664820114;1339.839219293691;920.1350730313484;925.7454200094893;947.8957314695378;957.7222605444482;970.2626004236831;5811.593188476766;5819.388964158787;5857.677827719516;6009.828083523671;6481.09264702942;455.6354916067133;459.4096585887119;460.13035363163647;470.06926285954;473.358599098217;4151.896202594899;4167.187398457272;4187.267228235047;4289.785510724451;4308.46144231971;10729.141668666643;10869.130469562417;10921.12630989519;10922;11026.558937642565;10882.347059176316;10883.619073332553;10900.291481053706;10904;10928.289661171999;8081.151479094728;8179.959100204461;8221.876671850046;8277.751667449986;8278.958605206935;5934.643921364732;5942.257217847769;5949.910751338647;6016.187814644967;6069.787557435645;10013.349132306377;10071.546780394754;10111.292209545261;10118.8482172766;10122.342047766871;9187.681789558897;10005.749856253651;10191.694249172537;10515.73710657209;10539.420331881513;8159.143289954469;8337.916620833714;8359.08050114499;8374.790630234293;8397.496150231005;9054.139856713602;9153.359264851397;9169.312301577274;9172.12864777845;9203.079692031011;7864.449488535747;8206;8223.95888020556;8279.50322980623;8310.87533686983;7811.531308121531;8023.6790528378215;8045.798855028671;8184.672613095648;8360.163983601591;6927.653617319214;7004.474664400293;7004.649767511502;7010.649467526501;7090.503664743418;5135.589152867687;5277.630565860506;5337.306150200449;5370.731463426891;5486.862828429321;5258.395284542326;5494.1758736189895;5539.25220095282;5549.556035517068;5677.489025987681 13:25:04 INFO - PROCESS | 13779 | |4;prototype.html;329.90267870978073;333.04084237396296;341.77955218883835;341.8427523339264;342.05933682373467;5197.324347834781;5245.213218017299;5250.579953603712;5252.448492908242;5265.578753699704;4969.055879382915;5062.797683007894;5213.9478605214035;5222.92165617516;5260.842174734755;4130.938035929464;4143.56492568279;4166.437530933315;4171.416001759756;4173.853915112972;4157.127003329289;4164;4174.478190226222;4197.874063778077;4218;3800.7909564973916;3944.6647035001915;3998.9600103999023;4074.97962510187;4124.8968775780695;4081.7755023473696;4098.426220329156;4122.546519882811;4123.731957422773;4142.627163555295;3650.7992060436663;3655.5065066215984;3660.396034654279;3668.394714872043;3672.926541469182;5057.558595800179;5072.923906141411;5109.233614957749;5120.385553733576;5183.740812959375;4719.315699223627;4737.957649317144;4745.928811067837;4755.714657120584;4757.8096876125255;5455.8363249102595;5468.945310546884;5478.205660179292;5502.944970550283;5513.8345849624575;3937.1731936293413;3999.600439516538;4024.6579040781567;4039.6162364575316;4047.3524236122375;5580.637258578179;5594.440555944414;5615.241942337814;5631.1271752878365;5679.109809780272;4156.625903668684;4167.5832416758085;4168.6039826216465;4169.833206671759;4172.769033135232;4101.687460012827;4190.161967606491;4192.742177346784;4209.915801683949;4235.512916014698;4679.929801052919;4688.835890743876;4708.6468514860835;4725.834595789131;4732.976335118303;5453.945460545344;5459.808906688247;5474.753636086386;5482.588805839578;5537.916931246034;1412.427966673499;1424.579748974055;1430.6494908747422;1452.8910331725162;1458.7811828225852;928.6168937222084;942.604106275366;952.64752041745;957.4016239850093;960.5389413081621;4689.132510485571;4699.506551812011;4719.811207551659;4722;4743.956329607481;4872.317875497433;4875.7074575525585;5001.89996200074;5007.799688012512;5014.52362025607;4532.410786597721;4675.4856965734425;4694.248920172824;4696;4728.598069164091;2666.6666666666665;2688.4085501189707;2695.6765188177546;2697.3930865555094;2697.932551686184;5050.318207042076;5050.772715227824;5084.898302033938;5151.7166555839785;5214.60890433219;4945.258211268267;5027.64806463544;5039.697618142924;5105.489451054865;5110.616703747234;5041.546260836542;5067.265246539305;5071.213961835995;5085.4914508548845;5088.643794934319;4983.476734942924;4985.6011519077665;4989.426215985208;4991.550760431579;5007.273945277987;4658.324542941323;4928.408590969107;4931.48219436954;4934.55588996992;4946.35697359341;4968.751562421937;5008.12195426715;5041.949580504148;5042.546170844642;5047.444781074006;3761.269815884724;3795.4686343912426;3818.7135964802196;3838;3964.623360780721;5571.9721401392735;5590.357108932525;5631.915521267266;5666.688332141772;5687.60186786921;5392.7573259202645;5466.644668096561;5467.6719396836315;5472.972635136799;5509.752061157177;5286.709230992178;5475.589330800126;5476.863078423071;5547;5560.138178582326;5454.509094181542;5464.781408743765;5478.808241711521;5479.2602998594675;5481.808136715196;5547.278853749148;5553.723303251101;5566.526845218202;5582.748776304995;5585.69278689676;5265.921011184759;5372.62391632582;5392.730363481732;5420.376656684532;5422.783088676409 13:25:04 INFO - PROCESS | 13779 | |5;yui.html;775.6470805783367;776.638862928738;777.2150128370345;822.5681517203467;833.1252185205533;14987.175705336202;16312.102834344107;16352.918235408835;16440;16696.2486688099;15484.922575387136;16035.518934431986;16045.35818567256;16061.196940153004;16073.517794466155;670.3062330487946;805.2631841864687;815.7430409421044;838.2916435611899;839.836231934773;819.4632515702194;821.9643249505637;825.78116799048;832.6045128563944;835.2733122183708;880.1242763450376;881.4711173296004;886;886.2289807867164;887.4409122252972;694.4375056204465;837.9622916968751;868.7437206024238;871.0462044061774;881.6649673124203;631.9652419116946;633.2464367402822;633.575504412045;634.0489266100849;634.1407392982488;15274.923625381913;15289.235538223043;15290.770638440432;15308.311125999357;15328.923355383264;14069.085509441853;14078.15531068129;14338.784918226234;14373.928130359282;14420.639484012878;13204.6698832529;13253.204807711569;13354.599362019155;13371;13957.092788968786;4439.223135951195;4578.748168850712;4608.884777880547;4661.2741147558745;4703.647226457995;75459.62270188614;76080.61959690221;77158;77364.81081513465;77512.22487775162;10347.120494757879;10383.636572719919;10768.3538987661;11002.50488728009;11493.540258389738;20277.188912443336;20454.38636840897;20457.795422045885;20475.07862146207;20548.280810171873;8336.238929677946;8568.314534837198;8601.655933762704;8670.393072484865;8862.468251904906;4721.881952951135;4779.861648727631;4824.49342819006;4894.192458244421;4910.21436570147;3600.243948770735;3671.155634204148;3709.7774133552075;3730.4404339349317;3735.14091758897;656.6815094679076;661.3254480429935;665.5374514712229;671.4796033074407;679.37497502298;609.8140067279522;666.9066330713704;695.5756988237172;710.7015053677468;735.6689489729644;9894.950525247328;10230.130438912776;10259.846102308471;10317.690469285933;10524.752033989826;652.6377860287586;675.9121314229119;686.8797960357017;697.2887654592288;718.6406796601699;4792.7124372537755;4987.875303117451;4990.775415106329;5004.874878128003;5038.899222015539;97441;98589;100242.49878750705;115849.42075289569;117398;96803.51598241963;98057;98544.50727746458;100859.49570252102;101038.95844166298;29591.704082959324;52510;66927.3307266921;84119.5794021026;85716.57141714376;10211.846822297523;10531.261871913204;10594.788104238027;10607.734806629587;10776.838347424638;51302.230466542285;51395.74302128465;51499.22751158661;52656.47343526516;53665.7316713414;49641;51519;54687.72656136694;76065.61967190128;80299;13607.727845443234;13720.588382348546;13742.587722368346;13778.415482219672;13897.0966887152;15468;15509.612259693147;15529.767053494432;15783.68432631364;15828.050316981018;8453.092966064829;13565.457381705017;13785.862141378859;14201.431942722176;15011;13888.375023123781;14331.211783351599;14553.781693274397;15456;15583.454579089677;14544.636384090483;14653.560393188221;14937.850621493646;15463.690726185638;15485.225738713245;11838.248489561647;12052.276863388224;12098.334591597195;12324;12442.688932776753;11958.760824783281;12127.636170914886;12464.813027804408;12486.12597118193;12634.178778379375 13:25:04 INFO - PROCESS | 13779 | __end_tp_report 13:25:04 INFO - PROCESS | 13779 | __start_cc_report 13:25:04 INFO - PROCESS | 13779 | _x_x_mozilla_cycle_collect,767 13:25:04 INFO - PROCESS | 13779 | __end_cc_report 13:25:04 INFO - PROCESS | 13779 | __startTimestamp1468614304364__endTimestamp 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | ------- Summary: start ------- 13:25:04 INFO - PROCESS | 13779 | Number of tests: 6 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | [#0] dojo.html Cycles:165 Average:5320.24 Median:5521.89 stddev:615.34 (11.1%) stddev-sans-first:590.83 13:25:04 INFO - PROCESS | 13779 | Values: 3047.3 3069.7 3091.0 3109.0 3116.3 5232.5 5328.5 5352.0 5422.3 5458.6 5161.7 5166.0 5239.8 5308.0 5335.5 4631.7 4689.6 4707.4 4764.1 4968.8 4890.3 4938.2 4940.2 4953.5 4956.2 4775.7 4777.6 4856.3 4857.8 4863.3 4786.6 4791.5 4800.7 4810.0 4904.9 4795.3 4835.0 4835.8 4841.5 4870.2 5223.6 5281.5 5330.2 5357.6 5382.2 5784.1 5828.2 5851.0 5857.8 5858.2 5863.1 5871.8 5873.2 5890.6 5895.4 5207.9 5317.0 5366.7 5388.3 5477.3 5964.0 5964.6 5965.1 5977.6 5980.0 5473.5 5712.9 5733.5 5746.7 5747.7 5632.2 5683.7 5693.5 5738.9 5739.1 5723.8 5730.5 5733.7 5736.2 5736.7 5539.6 5646.4 5724.9 5737.6 5737.8 4377.7 4394.5 4394.8 4438.5 4448.9 3889.1 3914.1 3922.1 3924.1 3947.0 5268.8 5329.8 5410.3 5436.6 5521.9 5740.9 5796.0 5798.2 5806.9 5850.1 5467.9 5472.3 5477.1 5478.0 5483.9 4887.9 4892.5 4897.9 4995.6 5054.0 5944.2 5949.6 5953.5 5955.5 5988.6 5751.6 5758.0 5769.9 5773.2 5775.3 5641.6 5751.2 5782.6 5806.4 5920.7 5555.3 5568.8 5569.3 5629.0 5650.3 5704.2 5733.7 5745.9 5747.4 5753.5 5404.6 5552.1 5558.8 5606.9 5642.0 5627.4 5633.9 5634.1 5635.0 5640.7 5372.8 5526.5 5530.2 5559.9 5584.0 5527.3 5563.2 5571.7 5612.6 5669.4 5494.0 5494.9 5498.1 5505.6 5511.2 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | [#1] ext.html Cycles:180 Average:64034.64 Median:24828.48 stddev:124785.68 (502.6%) stddev-sans-first:125044.90 13:25:04 INFO - PROCESS | 13779 | Values: 616.7 634.9 654.0 654.9 664.6 32004.0 34683.5 43152.1 44642.8 45263.8 45905.0 46210.5 46225.3 46273.3 46305.0 8898.3 9034.7 9046.9 9049.1 9063.9 8968.3 8993.2 9018.1 9074.3 9077.8 8981.0 9039.0 9040.3 9088.7 9165.3 8979.1 9007.5 9037.4 9048.0 9048.9 8877.6 8936.7 8963.9 8969.1 9046.2 44465.6 44611.8 44697.8 44710.3 44788.8 3516.1 3536.4 3710.7 3775.8 4421.2 33997.7 34048.8 34635.0 34723.8 34827.8 4488.9 4511.2 4519.3 4582.6 4702.3 376023.0 377529.1 379038.0 379186.0 380406.0 63588.0 63859.7 64061.4 64386.4 64395.4 67544.7 67586.7 67959.3 67990.0 68157.3 16808.2 16981.7 16992.7 17005.3 17009.6 12865.7 12936.4 12954.7 12980.7 12992.0 18002.6 20181.2 20204.6 20325.4 20347.2 7288.5 7300.3 7310.7 7405.3 7495.4 736.5 1077.7 1133.0 1142.8 1158.2 36331.5 37244.0 37430.3 37732.4 37828.6 1110.6 1163.5 1200.8 1211.1 1228.4 17161.0 17638.5 17879.4 17899.1 17968.1 582854.0 583067.0 589763.0 590517.0 592038.0 61865.4 63447.7 63485.0 63588.4 63758.4 1268.7 1351.4 1392.8 1415.9 1435.9 32849.5 35369.5 35477.6 35499.0 35711.0 53557.7 53598.7 54220.5 54435.5 54471.0 412864.0 421167.0 421232.0 422172.0 422555.0 21165.4 46765.5 47067.0 47964.5 49523.3 49272.0 49715.5 52330.5 53530.5 53955.2 43038.0 44992.0 45677.5 46747.3 47151.0 44108.8 44612.1 45145.8 46002.0 46540.3 43947.3 45250.0 45622.0 45655.5 45687.5 38754.8 39707.6 39911.0 40229.0 40606.8 29360.9 29470.9 29812.4 30178.4 30319.0 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | [#2] jquery.html Cycles:180 Average:29034.13 Median:2966.24 stddev:80601.08 (2717.3%) stddev-sans-first:80798.50 13:25:04 INFO - PROCESS | 13779 | Values: 394.7 397.8 398.3 399.6 416.7 13082.6 18993.6 20567.0 20625.6 20651.0 14912.0 19712.4 19802.5 20339.3 20649.8 5740.7 5903.0 5908.4 5909.6 5944.6 5192.4 5217.1 5221.9 5226.2 5234.7 4202.3 6136.2 6440.8 6450.8 6545.6 6233.3 6442.2 6499.1 6512.6 6537.3 5658.0 5662.9 5668.2 5696.4 5699.1 23269.4 23780.6 24572.9 24576.9 24971.3 2374.9 2413.0 2526.0 2794.4 3138.1 14887.3 15178.1 15197.5 15262.4 15289.0 1897.6 1922.2 1985.4 1986.1 2018.6 79342.0 81086.6 81464.0 85254.1 85481.0 10443.9 10564.2 10816.5 10832.7 10907.0 14917.4 14949.5 15018.5 15043.3 15079.2 8083.5 8084.9 8179.3 8250.0 8382.8 8005.9 8043.6 8044.8 8086.7 8154.9 5986.8 6219.6 6246.4 6545.1 6849.9 1739.7 1881.1 1937.5 1939.4 1947.1 919.1 929.8 939.5 969.6 974.2 18291.8 19134.7 19165.0 19190.3 19463.5 979.5 992.2 1013.4 1015.3 1044.7 10430.3 10729.6 10785.6 10870.8 10881.3 480637.0 489166.0 491946.0 493322.0 494802.0 83551.6 84561.0 85758.6 87300.6 87897.0 989.2 1015.7 1033.3 1040.1 1047.7 15608.4 16927.2 16976.1 17064.7 17273.2 41857.6 41954.8 42334.9 43007.4 43093.4 52690.7 53353.0 54228.5 54324.7 54984.7 8563.5 8802.1 8860.2 8880.9 8881.1 13541.9 13590.2 13834.2 13905.2 13968.7 11673.1 11721.3 11762.3 11872.9 12168.4 11808.1 11934.5 12045.8 12073.6 12297.8 11827.5 11934.9 11987.6 12088.4 12215.9 8573.1 8629.4 8754.6 8756.3 8977.2 11253.5 11975.9 12308.3 12439.8 12690.2 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | [#3] mootools.html Cycles:180 Average:5979.40 Median:4799.77 stddev:3436.28 (71.6%) stddev-sans-first:3428.03 13:25:04 INFO - PROCESS | 13779 | Values: 1313.7 1478.1 1493.6 1638.6 1780.3 8665.7 9064.3 9069.4 9307.4 9320.9 9071.5 9267.6 9268.7 9273.4 9277.6 2079.2 2145.8 2147.0 2410.9 2442.6 2063.3 2072.5 2338.2 2400.3 2419.1 2405.2 2407.2 2440.0 2441.2 2442.2 2031.4 2366.4 2375.5 2376.9 2380.3 2144.6 2206.0 2208.1 2217.1 2223.5 9328.5 9372.4 9398.2 9401.9 9423.8 5413.3 5550.3 5554.0 5554.6 5556.7 3419.1 3500.3 3572.1 3590.6 3608.7 1181.2 1224.6 1229.1 1244.9 1259.5 13038.2 13042.3 13049.9 13052.1 13058.5 4717.8 4766.2 4833.3 4896.9 4944.1 10868.4 10873.3 10881.8 10886.1 10892.6 5546.5 5551.4 5556.2 5563.3 5574.6 5001.7 5132.0 5136.6 5137.5 5162.9 4114.7 4139.4 4179.0 4219.2 4228.6 1286.3 1314.5 1330.7 1338.9 1339.8 920.1 925.7 947.9 957.7 970.3 5811.6 5819.4 5857.7 6009.8 6481.1 455.6 459.4 460.1 470.1 473.4 4151.9 4167.2 4187.3 4289.8 4308.5 10729.1 10869.1 10921.1 10922.0 11026.6 10882.3 10883.6 10900.3 10904.0 10928.3 8081.2 8180.0 8221.9 8277.8 8279.0 5934.6 5942.3 5949.9 6016.2 6069.8 10013.3 10071.5 10111.3 10118.8 10122.3 9187.7 10005.7 10191.7 10515.7 10539.4 8159.1 8337.9 8359.1 8374.8 8397.5 9054.1 9153.4 9169.3 9172.1 9203.1 7864.4 8206.0 8224.0 8279.5 8310.9 7811.5 8023.7 8045.8 8184.7 8360.2 6927.7 7004.5 7004.6 7010.6 7090.5 5135.6 5277.6 5337.3 5370.7 5486.9 5258.4 5494.2 5539.3 5549.6 5677.5 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | [#4] prototype.html Cycles:180 Average:4463.23 Median:4984.54 stddev:1266.47 (25.4%) stddev-sans-first:1231.44 13:25:04 INFO - PROCESS | 13779 | Values: 329.9 333.0 341.8 341.8 342.1 5197.3 5245.2 5250.6 5252.4 5265.6 4969.1 5062.8 5213.9 5222.9 5260.8 4130.9 4143.6 4166.4 4171.4 4173.9 4157.1 4164.0 4174.5 4197.9 4218.0 3800.8 3944.7 3999.0 4075.0 4124.9 4081.8 4098.4 4122.5 4123.7 4142.6 3650.8 3655.5 3660.4 3668.4 3672.9 5057.6 5072.9 5109.2 5120.4 5183.7 4719.3 4738.0 4745.9 4755.7 4757.8 5455.8 5468.9 5478.2 5502.9 5513.8 3937.2 3999.6 4024.7 4039.6 4047.4 5580.6 5594.4 5615.2 5631.1 5679.1 4156.6 4167.6 4168.6 4169.8 4172.8 4101.7 4190.2 4192.7 4209.9 4235.5 4679.9 4688.8 4708.6 4725.8 4733.0 5453.9 5459.8 5474.8 5482.6 5537.9 1412.4 1424.6 1430.6 1452.9 1458.8 928.6 942.6 952.6 957.4 960.5 4689.1 4699.5 4719.8 4722.0 4744.0 4872.3 4875.7 5001.9 5007.8 5014.5 4532.4 4675.5 4694.2 4696.0 4728.6 2666.7 2688.4 2695.7 2697.4 2697.9 5050.3 5050.8 5084.9 5151.7 5214.6 4945.3 5027.6 5039.7 5105.5 5110.6 5041.5 5067.3 5071.2 5085.5 5088.6 4983.5 4985.6 4989.4 4991.6 5007.3 4658.3 4928.4 4931.5 4934.6 4946.4 4968.8 5008.1 5041.9 5042.5 5047.4 3761.3 3795.5 3818.7 3838.0 3964.6 5572.0 5590.4 5631.9 5666.7 5687.6 5392.8 5466.6 5467.7 5473.0 5509.8 5286.7 5475.6 5476.9 5547.0 5560.1 5454.5 5464.8 5478.8 5479.3 5481.8 5547.3 5553.7 5566.5 5582.7 5585.7 5265.9 5372.6 5392.7 5420.4 5422.8 13:25:04 INFO - PROCESS | 13779 | 13:25:04 INFO - PROCESS | 13779 | [#5] yui.html Cycles:180 Average:19923.35 Median:4593.82 stddev:27662.32 (602.2%) stddev-sans-first:27702.56 13:25:04 INFO - PROCESS | 13779 | Values: 775.6 776.6 777.2 822.6 833.1 14987.2 16312.1 16352.9 16440.0 16696.2 15484.9 16035.5 16045.4 16061.2 16073.5 670.3 805.3 815.7 838.3 839.8 819.5 822.0 825.8 832.6 835.3 880.1 881.5 886.0 886.2 887.4 694.4 838.0 868.7 871.0 881.7 632.0 633.2 633.6 634.0 634.1 15274.9 15289.2 15290.8 15308.3 15328.9 14069.1 14078.2 14338.8 14373.9 14420.6 13204.7 13253.2 13354.6 13371.0 13957.1 4439.2 4578.7 4608.9 4661.3 4703.6 75459.6 76080.6 77158.0 77364.8 77512.2 10347.1 10383.6 10768.4 11002.5 11493.5 20277.2 20454.4 20457.8 20475.1 20548.3 8336.2 8568.3 8601.7 8670.4 8862.5 4721.9 4779.9 4824.5 4894.2 4910.2 3600.2 3671.2 3709.8 3730.4 3735.1 656.7 661.3 665.5 671.5 679.4 609.8 666.9 695.6 710.7 735.7 9895.0 10230.1 10259.8 10317.7 10524.8 652.6 675.9 686.9 697.3 718.6 4792.7 4987.9 4990.8 5004.9 5038.9 97441.0 98589.0 100242.5 115849.4 117398.0 96803.5 98057.0 98544.5 100859.5 101039.0 29591.7 52510.0 66927.3 84119.6 85716.6 10211.8 10531.3 10594.8 10607.7 10776.8 51302.2 51395.7 51499.2 52656.5 53665.7 49641.0 51519.0 54687.7 76065.6 80299.0 13607.7 13720.6 13742.6 13778.4 13897.1 15468.0 15509.6 15529.8 15783.7 15828.1 8453.1 13565.5 13785.9 14201.4 15011.0 13888.4 14331.2 14553.8 15456.0 15583.5 14544.6 14653.6 14937.9 15463.7 15485.2 11838.2 12052.3 12098.3 12324.0 12442.7 11958.8 12127.6 12464.8 12486.1 12634.2 13:25:04 INFO - PROCESS | 13779 | -------- Summary: end -------- 13:25:04 INFO - PROCESS | 13779 | 13:25:05 INFO - TEST-INFO | 13779: exit 0 13:25:05 INFO - TEST-OK | dromaeo_css | took 1113296ms 13:25:05 INFO - TEST-START | kraken 13:25:05 INFO - operating with platform_type : linux_ 13:25:05 INFO - Initialising browser for kraken test... 13:25:05 INFO - TEST-INFO | started process 13972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ug509/profile http://localhost:52719/getInfo.html) 13:25:09 INFO - PROCESS | 13972 | __metrics Screen width/height:1600/1200 13:25:09 INFO - PROCESS | 13972 | colorDepth:24 13:25:09 INFO - PROCESS | 13972 | Browser inner width/height: 1024/697 13:25:09 INFO - PROCESS | 13972 | __metrics 13:25:09 INFO - PROCESS | 13972 | 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" 13:25:09 INFO - PROCESS | 13972 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:25:10 INFO - TEST-INFO | 13972: exit 0 13:25:10 INFO - Browser initialized. 13:25:10 INFO - Running cycle 1/1 for kraken test... 13:25:10 INFO - TEST-INFO | started process 14056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ug509/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:25:22 INFO - PROCESS | 14056 | RSS: Main: 157257728 13:25:22 INFO - PROCESS | 14056 | 13:25:25 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52719/tests/kraken/driver.html?testName=audio-beat-detection) 13:25:25 INFO - PROCESS | 14056 | RSS: Main: 215846912 13:25:25 INFO - PROCESS | 14056 | 13:25:28 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52719/tests/kraken/driver.html?testName=audio-dft) 13:25:29 INFO - PROCESS | 14056 | RSS: Main: 204361728 13:25:29 INFO - PROCESS | 14056 | 13:25:32 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52719/tests/kraken/driver.html?testName=audio-fft) 13:25:32 INFO - PROCESS | 14056 | RSS: Main: 269484032 13:25:32 INFO - PROCESS | 14056 | 13:25:35 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52719/tests/kraken/driver.html?testName=audio-oscillator) 13:25:35 INFO - PROCESS | 14056 | RSS: Main: 180719616 13:25:35 INFO - PROCESS | 14056 | 13:25:37 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:25:38 INFO - PROCESS | 14056 | RSS: Main: 185344000 13:25:38 INFO - PROCESS | 14056 | 13:25:41 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52719/tests/kraken/driver.html?testName=imaging-darkroom) 13:25:42 INFO - PROCESS | 14056 | RSS: Main: 221241344 13:25:42 INFO - PROCESS | 14056 | 13:25:45 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52719/tests/kraken/driver.html?testName=imaging-desaturate) 13:25:46 INFO - PROCESS | 14056 | RSS: Main: 221810688 13:25:46 INFO - PROCESS | 14056 | 13:25:48 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52719/tests/kraken/driver.html?testName=json-parse-financial) 13:25:49 INFO - PROCESS | 14056 | RSS: Main: 222408704 13:25:49 INFO - PROCESS | 14056 | 13:25:51 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:25:51 INFO - PROCESS | 14056 | RSS: Main: 208822272 13:25:51 INFO - PROCESS | 14056 | 13:25:53 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:25:53 INFO - PROCESS | 14056 | RSS: Main: 213860352 13:25:53 INFO - PROCESS | 14056 | 13:25:55 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:25:56 INFO - PROCESS | 14056 | RSS: Main: 213106688 13:25:56 INFO - PROCESS | 14056 | 13:25:59 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:25:59 INFO - PROCESS | 14056 | RSS: Main: 221372416 13:25:59 INFO - PROCESS | 14056 | 13:26:02 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:26:02 INFO - PROCESS | 14056 | RSS: Main: 224022528 13:26:02 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | Cycle 1(1): loaded http://localhost:52719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52719/tests/kraken/driver.html?testName=ai-astar) 13:26:04 INFO - PROCESS | 14056 | RSS: Main: 265445376 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | __start_tp_report 13:26:04 INFO - PROCESS | 14056 | _x_x_mozilla_page_load 13:26:04 INFO - PROCESS | 14056 | _x_x_mozilla_page_load_details 13:26:04 INFO - PROCESS | 14056 | |i|pagename|runs| 13:26:04 INFO - PROCESS | 14056 | |0;ai-astar;104;114;111;112;112;113;112;110;111;113 13:26:04 INFO - PROCESS | 14056 | |1;audio-beat-detection;148;116;119;174;121;123;138;119;147;118 13:26:04 INFO - PROCESS | 14056 | |2;audio-dft;162;161;160;161;161;161;162;161;160;164 13:26:04 INFO - PROCESS | 14056 | |3;audio-fft;75;75;76;106;75;76;74;76;103;75 13:26:04 INFO - PROCESS | 14056 | |4;audio-oscillator;85;85;115;84;85;84;120;84;85;126 13:26:04 INFO - PROCESS | 14056 | |5;imaging-gaussian-blur;117;116;116;118;117;117;117;117;117;117 13:26:04 INFO - PROCESS | 14056 | |6;imaging-darkroom;148;147;147;146;147;146;146;148;147;146 13:26:04 INFO - PROCESS | 14056 | |7;imaging-desaturate;95;95;95;95;95;96;96;95;94;95 13:26:04 INFO - PROCESS | 14056 | |8;json-parse-financial;54;54;54;54;54;53;53;54;53;56 13:26:04 INFO - PROCESS | 14056 | |9;json-stringify-tinderbox;63;65;64;64;64;64;63;65;64;64 13:26:04 INFO - PROCESS | 14056 | |10;stanford-crypto-aes;80;76;81;76;75;75;83;75;75;86 13:26:04 INFO - PROCESS | 14056 | |11;stanford-crypto-ccm;128;120;126;124;126;119;122;120;160;122 13:26:04 INFO - PROCESS | 14056 | |12;stanford-crypto-pbkdf2;160;155;158;155;154;155;152;154;153;154 13:26:04 INFO - PROCESS | 14056 | |13;stanford-crypto-sha256-iterative;63;62;63;63;65;66;64;62;61;62 13:26:04 INFO - PROCESS | 14056 | __end_tp_report 13:26:04 INFO - PROCESS | 14056 | __start_cc_report 13:26:04 INFO - PROCESS | 14056 | _x_x_mozilla_cycle_collect,1622 13:26:04 INFO - PROCESS | 14056 | __end_cc_report 13:26:04 INFO - PROCESS | 14056 | __startTimestamp1468614364888__endTimestamp 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | ------- Summary: start ------- 13:26:04 INFO - PROCESS | 14056 | Number of tests: 14 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.78 (2.5%) stddev-sans-first:1.22 13:26:04 INFO - PROCESS | 14056 | Values: 104.0 114.0 111.0 112.0 112.0 113.0 112.0 110.0 111.0 113.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:130.50 stddev:19.07 (14.6%) stddev-sans-first:19.36 13:26:04 INFO - PROCESS | 14056 | Values: 148.0 116.0 119.0 174.0 121.0 123.0 138.0 119.0 147.0 118.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 13:26:04 INFO - PROCESS | 14056 | Values: 162.0 161.0 160.0 161.0 161.0 161.0 162.0 161.0 160.0 164.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:12.37 (16.5%) stddev-sans-first:12.92 13:26:04 INFO - PROCESS | 14056 | Values: 75.0 75.0 76.0 106.0 75.0 76.0 74.0 76.0 103.0 75.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.50 stddev:17.47 (20.7%) stddev-sans-first:18.13 13:26:04 INFO - PROCESS | 14056 | Values: 85.0 85.0 115.0 84.0 85.0 84.0 120.0 84.0 85.0 126.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:26:04 INFO - PROCESS | 14056 | Values: 117.0 116.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 13:26:04 INFO - PROCESS | 14056 | Values: 148.0 147.0 147.0 146.0 147.0 146.0 146.0 148.0 147.0 146.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:26:04 INFO - PROCESS | 14056 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 95.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 13:26:04 INFO - PROCESS | 14056 | Values: 54.0 54.0 54.0 54.0 54.0 53.0 53.0 54.0 53.0 56.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 13:26:04 INFO - PROCESS | 14056 | Values: 63.0 65.0 64.0 64.0 64.0 64.0 63.0 65.0 64.0 64.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:4.02 (5.2%) stddev-sans-first:4.21 13:26:04 INFO - PROCESS | 14056 | Values: 80.0 76.0 81.0 76.0 75.0 75.0 83.0 75.0 75.0 86.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.00 stddev:12.07 (9.7%) stddev-sans-first:12.80 13:26:04 INFO - PROCESS | 14056 | Values: 128.0 120.0 126.0 124.0 126.0 119.0 122.0 120.0 160.0 122.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:155.00 stddev:2.36 (1.5%) stddev-sans-first:1.67 13:26:04 INFO - PROCESS | 14056 | Values: 160.0 155.0 158.0 155.0 154.0 155.0 152.0 154.0 153.0 154.0 13:26:04 INFO - PROCESS | 14056 | 13:26:04 INFO - PROCESS | 14056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:1.62 13:26:04 INFO - PROCESS | 14056 | Values: 63.0 62.0 63.0 63.0 65.0 66.0 64.0 62.0 61.0 62.0 13:26:04 INFO - PROCESS | 14056 | -------- Summary: end -------- 13:26:04 INFO - PROCESS | 14056 | 13:26:05 INFO - TEST-INFO | 14056: exit 0 13:26:05 INFO - TEST-OK | kraken | took 60743ms 13:26:05 INFO - SUITE-END | took 1174s 13:26:06 INFO - Completed test suite (00:19:34) 13:26:06 INFO - javascript benchmark 13:26:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.3143542702896, 3069.6623371429155, 3091.010876519513, 3108.9844550777248, 3116.25209949612, 5232.529072383485, 5328.520433161015, 5352.0098781725355, 5422.3493180818305, 5458.645188062773, 5161.741912904358, 5165.9668066386685, 5239.842804715865, 5308.044551980642, 5335.466453354663, 4631.652626053043, 4689.601383882374, 4707.411573553306, 4764.142454358214, 4968.776405061781, 4890.290907818364, 4938.234573641073, 4940.1601727706375, 4953.4798846121175, 4956.2070068789, 4775.689580177294, 4777.641676874248, 4856.320115183859, 4857.757112144379, 4863.343448634424, 4786.64100192487, 4791.520847915215, 4800.687955282895, 4809.975950120262, 4904.901901961976, 4795.2807078938085, 4834.975825120887, 4835.830745923911, 4841.515848415165, 4870.196417591129, 5223.582113430916, 5281.471852814726, 5330.227117068003, 5357.598180136466, 5382.2464854920345, 5784.07454807233, 5828.242328497268, 5850.97074514629, 5857.824265272006, 5858.209141765849, 5863.061910094407, 5871.823845284648, 5873.236479257712, 5890.587658863881, 5895.380984996556, 5207.947920520822, 5317.042932272189, 5366.70483123428, 5388.299521062276, 5477.3427188737605, 5964.045752679551, 5964.552658550626, 5965.135055417027, 5977.551683623746, 5980.0132978059, 5473.480019398151, 5712.885742285131, 5733.541316694655, 5746.741396637161, 5747.741351639186, 5632.183333416631, 5683.7442315095095, 5693.5160511357, 5738.885222295531, 5739.110437882135, 5723.7996670116345, 5730.5129064030025, 5733.655980641091, 5736.225609542658, 5736.741846616829, 5539.584531160179, 5646.350669672958, 5724.914126288109, 5737.5983681141915, 5737.799177028867, 4377.671674624416, 4394.538573449806, 4394.8242070317465, 4438.489573699066, 4448.888777780517, 3889.144388234584, 3914.099757055893, 3922.1371298314325, 3924.0778417071965, 3946.960530394717, 5268.78924843002, 5329.840104796862, 5410.323709536308, 5436.592255580847, 5521.889562208814, 5740.913886291709, 5796.0, 5798.188253644493, 5806.9419305806405, 5850.063989761703, 5467.890642187134, 5472.26124473199, 5477.096279113981, 5478.013957487611, 5483.890322193613, 4887.853364399074, 4892.510748925079, 4897.877553061202, 4995.600351971833, 5053.9747301264, 5944.167816505693, 5949.583529152917, 5953.464188223081, 5955.493783028491, 5988.610740301867, 5751.568632352507, 5757.971210143923, 5769.94230057694, 5773.162891380643, 5775.33583637887, 5641.576881733804, 5751.194832723339, 5782.624129431573, 5806.4483874033585, 5920.733566989582, 5555.2778138841695, 5568.777248909998, 5569.275994120739, 5628.971855140698, 5650.3219613646625, 5704.229928959538, 5733.684647344436, 5745.856353591026, 5747.367789543064, 5753.510951569164, 5404.567634589145, 5552.056150454513, 5558.805441809517, 5606.915896261641, 5642.0, 5627.352854421794, 5633.88732225345, 5634.098544232903, 5634.971825141012, 5640.661560306395, 5372.758225879923, 5526.50261476469, 5530.198121272312, 5559.888802223852, 5584.0227960106, 5527.281453411031, 5563.1655251710945, 5571.7492712828835, 5612.579056570855, 5669.433056694463, 5493.956148331804, 5494.862628434161, 5498.147787093007, 5505.614606977473, 5511.200875873056], "value": 5278.177092618822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.67932675009, 634.9111124442577, 653.9901901471479, 654.9476041916647, 664.6477366995495, 32004.0, 34683.47974780377, 43152.136957260875, 44642.776786116025, 45263.77368113155, 45905.0, 46210.53789462104, 46225.30662040072, 46273.30590041152, 46305.0, 8898.33262505313, 9034.728958131267, 9046.909530904673, 9049.095090490931, 9063.864042039375, 8968.327375446836, 8993.190612844843, 9018.05310442404, 9074.319426043041, 9077.818443631124, 8980.955095224515, 9039.0, 9040.276777857756, 9088.681896133636, 9165.266778657691, 8979.057198994142, 9007.504587247699, 9037.367384283103, 9048.0, 9048.864267036033, 8877.556122193864, 8936.687215947475, 8963.865542016874, 8969.14793094655, 9046.231070359026, 44465.55534444647, 44611.77694111509, 44697.77651111756, 44710.32934505985, 44788.77605611984, 3516.1209697575605, 3536.416491278936, 3710.666040056408, 3775.7923314217705, 4421.159979603897, 33997.660023399694, 34048.82975585131, 34635.0, 34723.82638086793, 34827.825860870784, 4488.932666010012, 4511.187986162489, 4519.254323036695, 4582.6104781093645, 4702.3416721659, 376023.0, 377529.1123544392, 379038.0, 379186.0, 380406.0, 63588.0, 63859.6807015962, 64061.35938640554, 64386.356136438975, 64395.356046439876, 67544.66227668928, 67586.66206668936, 67959.3204067953, 67990.0, 68157.3184268151, 16808.243629036722, 16981.745273820903, 16992.74510882338, 17005.319787208373, 17009.574760631083, 12865.742685146244, 12936.417861196269, 12954.740905181843, 12980.67548311281, 12992.0, 18002.635148603928, 20181.192752290037, 20204.595908081756, 20325.390238292875, 20347.186112555628, 7288.489805713655, 7300.306470885257, 7310.733672561417, 7405.259474052659, 7495.437842161859, 736.5213678531197, 1077.6766969909152, 1133.002957397485, 1142.845715828369, 1158.1834806461425, 36331.4550281746, 37244.0, 37430.251394972496, 37732.43401348982, 37828.62171378306, 1110.5779803674714, 1163.4531770068224, 1200.8438902942562, 1211.1340391620033, 1228.3980849383915, 17161.0, 17638.470845874643, 17879.37422190243, 17899.10504474771, 17968.1015949202, 582854.0, 583067.0, 589763.0, 590517.0, 592038.0, 61865.38134618686, 63447.6827615859, 63485.0, 63588.36411635917, 63758.36241637617, 1268.7272236469203, 1351.398627610704, 1392.8258967629047, 1415.8903234181203, 1435.9210243436503, 32849.50725739163, 35369.46945795764, 35477.645223547435, 35499.0, 35711.0, 53557.73221133869, 53598.73200633972, 54220.45779542312, 54435.45564544304, 54471.0, 412864.0, 421167.0, 421232.0, 422172.0, 422555.0, 21165.365039048855, 46765.53234467748, 47067.0, 47964.5203547974, 49523.25715114204, 49272.0, 49715.502844972536, 52330.47669523256, 53530.464695352544, 53955.22313438022, 43038.0, 44992.0, 45677.54322456866, 46747.29879051749, 47151.0, 44108.779456102515, 44612.10775784531, 45145.77427112844, 46002.0, 46540.30189547227, 43947.34078988882, 45250.0, 45622.0, 45655.543444565126, 45687.54312456833, 38754.80622596982, 39707.60292397039, 39911.0, 40229.0, 40606.79696601498, 29360.853195733886, 29470.852645736635, 29812.403751924405, 30178.396432071673, 30319.0], "value": 21417.879947268182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.68425259792195, 397.7931475632671, 398.3168865395846, 399.5525011986575, 416.65209550025725, 13082.553963931952, 18993.620127597438, 20567.0, 20625.587488250225, 20650.967451627414, 14912.0, 19712.40862774119, 19802.504937376572, 20339.28812491563, 20649.793502064975, 5740.655560666363, 5903.026000709878, 5908.379620139888, 5909.556783241253, 5944.583879128462, 5192.428832828386, 5217.139172036628, 5221.947780522184, 5226.163813789775, 5234.659747116444, 4202.2856114460465, 6136.171616831715, 6440.806775796734, 6450.8064758057335, 6545.639989800559, 6233.283172435137, 6442.194725659293, 6499.057636642684, 6512.5766825156215, 6537.313582073885, 5657.971710141464, 5662.915056274159, 5668.178114173422, 5696.401877802812, 5699.059655156894, 23269.418264543354, 23780.643290350657, 24572.877135614388, 24576.877115614487, 24971.250862474153, 2374.8812559371963, 2412.986545650831, 2526.0401047601977, 2794.3712664650493, 3138.10563989262, 14887.330070146761, 15178.089314641156, 15197.468088616955, 15262.38950441981, 15289.0, 1897.5635603811063, 1922.1926790747918, 1985.434151266882, 1986.145957238387, 2018.5660083082207, 79342.0, 81086.59456702738, 81464.0, 85254.14745852524, 85481.0, 10443.94778026105, 10564.207684423698, 10816.513256903458, 10832.675019749262, 10907.0, 14917.40330386794, 14949.476768313058, 15018.549443516711, 15043.323050462755, 15079.24603769807, 8083.544961906913, 8084.919150808417, 8179.304759095544, 8249.958750206211, 8382.83234335322, 8005.919940800517, 8043.597820109088, 8044.839103217902, 8086.716964906318, 8154.8776768348525, 5986.760529578855, 6219.626822390581, 6246.375362463808, 6545.116409284781, 6849.931500684929, 1739.7303417969981, 1881.1158755384947, 1937.5059359863426, 1939.4084804134875, 1947.1140631012854, 919.1314208073306, 929.8047410043831, 939.4973689076311, 969.6121551379505, 974.2060220919927, 18291.84335245697, 19134.71297930532, 19165.0, 19190.328338508087, 19463.513412164808, 979.5298256836759, 992.1864071461476, 1013.4375421640913, 1015.2588610314511, 1044.6970378590124, 10430.26988110825, 10729.577618168452, 10785.56857725698, 10870.782584348426, 10881.292715973595, 480637.0, 489166.0, 491946.0, 493322.0, 494802.0, 83551.5822420884, 84561.0, 85758.5712071448, 87300.56349718338, 87897.0, 989.2135752076972, 1015.7155996321042, 1033.3231733214907, 1040.1314902056715, 1047.6909311753052, 15608.375664973273, 16927.15364231808, 16976.06631635272, 17064.65870682604, 17273.222704978056, 41857.581424185366, 41954.79022604867, 42334.941626459586, 43007.354889676055, 43093.35359969666, 52690.736546318556, 53353.0, 54228.457715422344, 54324.728376359446, 54984.725076374365, 8563.486190828571, 8802.119788021148, 8860.246879015356, 8880.86678699807, 8881.067487913677, 13541.86458135406, 13590.184588924696, 13834.23911684867, 13905.16569005863, 13968.720625587635, 11673.12451566119, 11721.300411440123, 11762.294262344287, 11872.940635296769, 12168.391580421121, 11808.114391420506, 11934.522619095485, 12045.75908481843, 12073.57742479009, 12297.815532767194, 11827.526898923947, 11934.880651193376, 11987.561492620942, 12088.39558022113, 12215.938920305342, 8573.142685731627, 8629.39594228423, 8754.60604272822, 8756.343274254585, 8977.23693486061, 11253.549858005588, 11975.940120299343, 12308.323042232763, 12439.813402798783, 12690.175138615961], "value": 9465.671974973868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.6715821044738, 1478.1057460236557, 1493.5668656089733, 1638.5821615488048, 1780.3056807844935, 8665.69670061548, 9064.320175986802, 9069.365144439891, 9307.441553506778, 9320.90679093209, 9071.455712657245, 9267.582958766854, 9268.72193834186, 9273.350865439423, 9277.582508787104, 2079.1995081893506, 2145.7639659637425, 2146.957060858782, 2410.855348679076, 2442.6213936839818, 2063.3397312859893, 2072.492239401349, 2338.181636427254, 2400.2799160251943, 2419.1049311754678, 2405.2062819269686, 2407.193590147294, 2440.023990403835, 2441.1944058460667, 2442.157455677788, 2031.4311992642083, 2366.420227044368, 2375.5248950210025, 2376.8930398132125, 2380.262118743195, 2144.5925274197853, 2206.0403724379944, 2208.1277895231456, 2217.1242359268, 2223.466368071667, 9328.533573321307, 9372.39079459833, 9398.201152902011, 9401.905980940172, 9423.764405889839, 5413.296271484721, 5550.333959924795, 5554.0, 5554.638948468337, 5556.722163891789, 3419.145213696576, 3500.264944361687, 3572.1069732566857, 3590.569131704186, 3608.657177568127, 1181.1908842442954, 1224.5714000099983, 1229.1088960503564, 1244.9439775210137, 1259.4710221706905, 13038.217706937614, 13042.282674452901, 13049.86950130496, 13052.086353955227, 13058.477660893554, 4717.787699553528, 4766.217426849646, 4833.32333473314, 4896.877578060577, 4944.060628480577, 10868.402237876835, 10873.347599144077, 10881.782364352668, 10886.074683651977, 10892.61875834342, 5546.473085056913, 5551.417101204396, 5556.16657501378, 5563.332400111932, 5574.554035677136, 5001.674891132065, 5131.974340128276, 5136.5890728741615, 5137.51193636604, 5162.896742065138, 4114.670826333886, 4139.379093135994, 4179.0, 4219.219444402734, 4228.556001619847, 1286.273255610577, 1314.5464814638933, 1330.6673331667084, 1338.919664820114, 1339.839219293691, 920.1350730313484, 925.7454200094893, 947.8957314695378, 957.7222605444482, 970.2626004236831, 5811.593188476766, 5819.388964158787, 5857.677827719516, 6009.828083523671, 6481.09264702942, 455.6354916067133, 459.4096585887119, 460.13035363163647, 470.06926285954, 473.358599098217, 4151.896202594899, 4167.187398457272, 4187.267228235047, 4289.785510724451, 4308.46144231971, 10729.141668666643, 10869.130469562417, 10921.12630989519, 10922.0, 11026.558937642565, 10882.347059176316, 10883.619073332553, 10900.291481053706, 10904.0, 10928.289661171999, 8081.151479094728, 8179.959100204461, 8221.876671850046, 8277.751667449986, 8278.958605206935, 5934.643921364732, 5942.257217847769, 5949.910751338647, 6016.187814644967, 6069.787557435645, 10013.349132306377, 10071.546780394754, 10111.292209545261, 10118.8482172766, 10122.342047766871, 9187.681789558897, 10005.749856253651, 10191.694249172537, 10515.73710657209, 10539.420331881513, 8159.143289954469, 8337.916620833714, 8359.08050114499, 8374.790630234293, 8397.496150231005, 9054.139856713602, 9153.359264851397, 9169.312301577274, 9172.12864777845, 9203.079692031011, 7864.449488535747, 8206.0, 8223.95888020556, 8279.50322980623, 8310.87533686983, 7811.531308121531, 8023.6790528378215, 8045.798855028671, 8184.672613095648, 8360.163983601591, 6927.653617319214, 7004.474664400293, 7004.649767511502, 7010.649467526501, 7090.503664743418, 5135.589152867687, 5277.630565860506, 5337.306150200449, 5370.731463426891, 5486.862828429321, 5258.395284542326, 5494.1758736189895, 5539.25220095282, 5549.556035517068, 5677.489025987681], "value": 4679.040373941348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.90267870978073, 333.04084237396296, 341.77955218883835, 341.8427523339264, 342.05933682373467, 5197.324347834781, 5245.213218017299, 5250.579953603712, 5252.448492908242, 5265.578753699704, 4969.055879382915, 5062.797683007894, 5213.9478605214035, 5222.92165617516, 5260.842174734755, 4130.938035929464, 4143.56492568279, 4166.437530933315, 4171.416001759756, 4173.853915112972, 4157.127003329289, 4164.0, 4174.478190226222, 4197.874063778077, 4218.0, 3800.7909564973916, 3944.6647035001915, 3998.9600103999023, 4074.97962510187, 4124.8968775780695, 4081.7755023473696, 4098.426220329156, 4122.546519882811, 4123.731957422773, 4142.627163555295, 3650.7992060436663, 3655.5065066215984, 3660.396034654279, 3668.394714872043, 3672.926541469182, 5057.558595800179, 5072.923906141411, 5109.233614957749, 5120.385553733576, 5183.740812959375, 4719.315699223627, 4737.957649317144, 4745.928811067837, 4755.714657120584, 4757.8096876125255, 5455.8363249102595, 5468.945310546884, 5478.205660179292, 5502.944970550283, 5513.8345849624575, 3937.1731936293413, 3999.600439516538, 4024.6579040781567, 4039.6162364575316, 4047.3524236122375, 5580.637258578179, 5594.440555944414, 5615.241942337814, 5631.1271752878365, 5679.109809780272, 4156.625903668684, 4167.5832416758085, 4168.6039826216465, 4169.833206671759, 4172.769033135232, 4101.687460012827, 4190.161967606491, 4192.742177346784, 4209.915801683949, 4235.512916014698, 4679.929801052919, 4688.835890743876, 4708.6468514860835, 4725.834595789131, 4732.976335118303, 5453.945460545344, 5459.808906688247, 5474.753636086386, 5482.588805839578, 5537.916931246034, 1412.427966673499, 1424.579748974055, 1430.6494908747422, 1452.8910331725162, 1458.7811828225852, 928.6168937222084, 942.604106275366, 952.64752041745, 957.4016239850093, 960.5389413081621, 4689.132510485571, 4699.506551812011, 4719.811207551659, 4722.0, 4743.956329607481, 4872.317875497433, 4875.7074575525585, 5001.89996200074, 5007.799688012512, 5014.52362025607, 4532.410786597721, 4675.4856965734425, 4694.248920172824, 4696.0, 4728.598069164091, 2666.6666666666665, 2688.4085501189707, 2695.6765188177546, 2697.3930865555094, 2697.932551686184, 5050.318207042076, 5050.772715227824, 5084.898302033938, 5151.7166555839785, 5214.60890433219, 4945.258211268267, 5027.64806463544, 5039.697618142924, 5105.489451054865, 5110.616703747234, 5041.546260836542, 5067.265246539305, 5071.213961835995, 5085.4914508548845, 5088.643794934319, 4983.476734942924, 4985.6011519077665, 4989.426215985208, 4991.550760431579, 5007.273945277987, 4658.324542941323, 4928.408590969107, 4931.48219436954, 4934.55588996992, 4946.35697359341, 4968.751562421937, 5008.12195426715, 5041.949580504148, 5042.546170844642, 5047.444781074006, 3761.269815884724, 3795.4686343912426, 3818.7135964802196, 3838.0, 3964.623360780721, 5571.9721401392735, 5590.357108932525, 5631.915521267266, 5666.688332141772, 5687.60186786921, 5392.7573259202645, 5466.644668096561, 5467.6719396836315, 5472.972635136799, 5509.752061157177, 5286.709230992178, 5475.589330800126, 5476.863078423071, 5547.0, 5560.138178582326, 5454.509094181542, 5464.781408743765, 5478.808241711521, 5479.2602998594675, 5481.808136715196, 5547.278853749148, 5553.723303251101, 5566.526845218202, 5582.748776304995, 5585.69278689676, 5265.921011184759, 5372.62391632582, 5392.730363481732, 5420.376656684532, 5422.783088676409], "value": 4068.132558907481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.6470805783367, 776.638862928738, 777.2150128370345, 822.5681517203467, 833.1252185205533, 14987.175705336202, 16312.102834344107, 16352.918235408835, 16440.0, 16696.2486688099, 15484.922575387136, 16035.518934431986, 16045.35818567256, 16061.196940153004, 16073.517794466155, 670.3062330487946, 805.2631841864687, 815.7430409421044, 838.2916435611899, 839.836231934773, 819.4632515702194, 821.9643249505637, 825.78116799048, 832.6045128563944, 835.2733122183708, 880.1242763450376, 881.4711173296004, 886.0, 886.2289807867164, 887.4409122252972, 694.4375056204465, 837.9622916968751, 868.7437206024238, 871.0462044061774, 881.6649673124203, 631.9652419116946, 633.2464367402822, 633.575504412045, 634.0489266100849, 634.1407392982488, 15274.923625381913, 15289.235538223043, 15290.770638440432, 15308.311125999357, 15328.923355383264, 14069.085509441853, 14078.15531068129, 14338.784918226234, 14373.928130359282, 14420.639484012878, 13204.6698832529, 13253.204807711569, 13354.599362019155, 13371.0, 13957.092788968786, 4439.223135951195, 4578.748168850712, 4608.884777880547, 4661.2741147558745, 4703.647226457995, 75459.62270188614, 76080.61959690221, 77158.0, 77364.81081513465, 77512.22487775162, 10347.120494757879, 10383.636572719919, 10768.3538987661, 11002.50488728009, 11493.540258389738, 20277.188912443336, 20454.38636840897, 20457.795422045885, 20475.07862146207, 20548.280810171873, 8336.238929677946, 8568.314534837198, 8601.655933762704, 8670.393072484865, 8862.468251904906, 4721.881952951135, 4779.861648727631, 4824.49342819006, 4894.192458244421, 4910.21436570147, 3600.243948770735, 3671.155634204148, 3709.7774133552075, 3730.4404339349317, 3735.14091758897, 656.6815094679076, 661.3254480429935, 665.5374514712229, 671.4796033074407, 679.37497502298, 609.8140067279522, 666.9066330713704, 695.5756988237172, 710.7015053677468, 735.6689489729644, 9894.950525247328, 10230.130438912776, 10259.846102308471, 10317.690469285933, 10524.752033989826, 652.6377860287586, 675.9121314229119, 686.8797960357017, 697.2887654592288, 718.6406796601699, 4792.7124372537755, 4987.875303117451, 4990.775415106329, 5004.874878128003, 5038.899222015539, 97441.0, 98589.0, 100242.49878750705, 115849.42075289569, 117398.0, 96803.51598241963, 98057.0, 98544.50727746458, 100859.49570252102, 101038.95844166298, 29591.704082959324, 52510.0, 66927.3307266921, 84119.5794021026, 85716.57141714376, 10211.846822297523, 10531.261871913204, 10594.788104238027, 10607.734806629587, 10776.838347424638, 51302.230466542285, 51395.74302128465, 51499.22751158661, 52656.47343526516, 53665.7316713414, 49641.0, 51519.0, 54687.72656136694, 76065.61967190128, 80299.0, 13607.727845443234, 13720.588382348546, 13742.587722368346, 13778.415482219672, 13897.0966887152, 15468.0, 15509.612259693147, 15529.767053494432, 15783.68432631364, 15828.050316981018, 8453.092966064829, 13565.457381705017, 13785.862141378859, 14201.431942722176, 15011.0, 13888.375023123781, 14331.211783351599, 14553.781693274397, 15456.0, 15583.454579089677, 14544.636384090483, 14653.560393188221, 14937.850621493646, 15463.690726185638, 15485.225738713245, 11838.248489561647, 12052.276863388224, 12098.334591597195, 12324.0, 12442.688932776753, 11958.760824783281, 12127.636170914886, 12464.813027804408, 12486.12597118193, 12634.178778379375], "value": 7681.071306488142, "unit": "score"}], "name": "dromaeo_css", "value": 7340.728972028507, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 111.0, 112.0, 112.0, 113.0, 112.0, 110.0, 111.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 119.0, 174.0, 121.0, 123.0, 138.0, 119.0, 147.0, 118.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 160.0, 164.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 106.0, 75.0, 76.0, 74.0, 76.0, 103.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 84.0, 85.0, 84.0, 120.0, 84.0, 85.0, 126.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0, 56.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 81.0, 76.0, 75.0, 75.0, 83.0, 75.0, 75.0, 86.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 126.0, 124.0, 126.0, 119.0, 122.0, 120.0, 160.0, 122.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 158.0, 155.0, 154.0, 155.0, 152.0, 154.0, 153.0, 154.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 65.0, 66.0, 64.0, 62.0, 61.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1480.8999999999999, "alertThreshold": 2.0}]} 13:26:06 INFO - Return code: 0 13:26:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:26:06 INFO - # TBPL SUCCESS # 13:26:06 INFO - Running post-action listener: _resource_record_post_action 13:26:06 INFO - ##### 13:26:06 INFO - ##### Finished run-tests step (success) 13:26:06 INFO - ##### 13:26:06 INFO - Running post-run listener: _resource_record_post_run 13:26:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555106304; Read time: 16; Write time: 548228 13:26:06 INFO - TinderboxPrint: CPU usage
13.1% 13:26:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:26:06 INFO - TinderboxPrint: I/O write bytes / time
555,106,304 / 548,228 13:26:06 INFO - TinderboxPrint: CPU idle
8,263.4 (86.9%) 13:26:06 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 13:26:06 INFO - TinderboxPrint: Swap in / out
0 / 0 13:26:06 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257486848; Read time: 0; Write time: 313356 13:26:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 297619456; Read time: 0; Write time: 234872 13:26:06 INFO - Running post-run listener: _upload_blobber_files 13:26:06 INFO - Blob upload gear active. 13:26:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:26:06 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 13:26:06 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'] 13:26:06 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 13:26:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:10 INFO - (blobuploader) - INFO - Done attempting. 13:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:11 INFO - (blobuploader) - INFO - Done attempting. 13:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:12 INFO - (blobuploader) - INFO - Done attempting. 13:26:12 INFO - (blobuploader) - INFO - Iteration through files over. 13:26:12 INFO - Return code: 0 13:26:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:26:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:26:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a78e57d1dc8de9f47d000caa4ebf55316ace649288d9aab946b6965f12a48bb201549e01c06cd8c5cafd3c39763d59aa002d904edc480592dc65806d13cc34e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8bf239efdbb7beb01b7114b618e700973233ab38c8804eb6e3040b0164f9a5ff3c6723b57721771181ecbb510368648d792d52eff10ca2ccbadc9168408d6d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49cd2867a610ac217818bdbb36de33b3abe5c6e6b877adb487376e42a452090db1231aed2c2d8cf18018ede4d9889e3eca648e0c65fc2cddb90ff0edd08f594c"} 13:26:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:26:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:26:12 INFO - Contents: 13:26:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a78e57d1dc8de9f47d000caa4ebf55316ace649288d9aab946b6965f12a48bb201549e01c06cd8c5cafd3c39763d59aa002d904edc480592dc65806d13cc34e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8bf239efdbb7beb01b7114b618e700973233ab38c8804eb6e3040b0164f9a5ff3c6723b57721771181ecbb510368648d792d52eff10ca2ccbadc9168408d6d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49cd2867a610ac217818bdbb36de33b3abe5c6e6b877adb487376e42a452090db1231aed2c2d8cf18018ede4d9889e3eca648e0c65fc2cddb90ff0edd08f594c"} 13:26:12 INFO - Running post-run listener: copy_logs_to_upload_dir 13:26:12 INFO - Copying logs to upload dir... 13:26:12 INFO - mkdir: /builds/slave/test/build/upload/logs 13:26:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.936787 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-15 13:26:11.803094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:26:11.806641) ========= 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=52faae308a556c440401f8e5000001e8-1468613136.694900-96965533 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/9a78e57d1dc8de9f47d000caa4ebf55316ace649288d9aab946b6965f12a48bb201549e01c06cd8c5cafd3c39763d59aa002d904edc480592dc65806d13cc34e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8bf239efdbb7beb01b7114b618e700973233ab38c8804eb6e3040b0164f9a5ff3c6723b57721771181ecbb510368648d792d52eff10ca2ccbadc9168408d6d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49cd2867a610ac217818bdbb36de33b3abe5c6e6b877adb487376e42a452090db1231aed2c2d8cf18018ede4d9889e3eca648e0c65fc2cddb90ff0edd08f594c"} build_url:https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/JCXso76mRL28Tgr07VUslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a78e57d1dc8de9f47d000caa4ebf55316ace649288d9aab946b6965f12a48bb201549e01c06cd8c5cafd3c39763d59aa002d904edc480592dc65806d13cc34e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8bf239efdbb7beb01b7114b618e700973233ab38c8804eb6e3040b0164f9a5ff3c6723b57721771181ecbb510368648d792d52eff10ca2ccbadc9168408d6d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49cd2867a610ac217818bdbb36de33b3abe5c6e6b877adb487376e42a452090db1231aed2c2d8cf18018ede4d9889e3eca648e0c65fc2cddb90ff0edd08f594c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:26:11.831900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:26:11.832249) ========= 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=52faae308a556c440401f8e5000001e8-1468613136.694900-96965533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:26:11.914073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:26:11.914435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:26:11.914721) ========= ========= Total master_lag: 0.27 =========