builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1470471494.56 results: success (0) buildid: 20160805234720 builduid: bd1e2d1a71c744099ebe26d9a2d9569c revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.561495) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.562087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.562498) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.647904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.648203) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-06 01:18:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.1M=0s 2016-08-06 01:18:14 (96.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126344 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.788796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.789215) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021798 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.838647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:14.839028) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --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 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --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=4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-06 01:18:14,987 truncating revision to first 12 chars 2016-08-06 01:18:14,987 Setting DEBUG logging. 2016-08-06 01:18:14,987 attempt 1/10 2016-08-06 01:18:14,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/115ec609a6bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 01:18:15,452 unpacking tar archive at: fx-team-115ec609a6bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:15.682281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:15.682600) ========= script_repo_revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:15.683016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:15.683340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 01:18:15.693667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-06 01:18:15.694101) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:18:15 INFO - MultiFileLogger online at 20160806 01:18:15 in /builds/slave/test 01:18:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:18:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:18:15 INFO - {'append_to_log': False, 01:18:15 INFO - 'base_work_dir': '/builds/slave/test', 01:18:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:18:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:18:15 INFO - 'branch': 'Fx-Team-Non-PGO', 01:18:15 INFO - 'buildbot_json_path': 'buildprops.json', 01:18:15 INFO - 'config_files': ('talos/linux_config.py',), 01:18:15 INFO - 'default_actions': ('clobber', 01:18:15 INFO - 'read-buildbot-config', 01:18:15 INFO - 'download-and-extract', 01:18:15 INFO - 'populate-webroot', 01:18:15 INFO - 'create-virtualenv', 01:18:15 INFO - 'install', 01:18:15 INFO - 'run-tests'), 01:18:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:18:15 INFO - 'download_minidump_stackwalk': True, 01:18:15 INFO - 'download_symbols': 'ondemand', 01:18:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:18:15 INFO - 'tooltool.py': '/tools/tooltool.py', 01:18:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:18:15 INFO - '/tools/misc-python/virtualenv.py')}, 01:18:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:18:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:18:15 INFO - 'installer_path': 'installer.exe', 01:18:15 INFO - 'log_level': 'info', 01:18:15 INFO - 'log_name': 'talos', 01:18:15 INFO - 'log_to_console': True, 01:18:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:18:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:18:15 INFO - 'opt_config_files': (), 01:18:15 INFO - 'pip_index': False, 01:18:15 INFO - 'sps_profile': False, 01:18:15 INFO - 'sps_profile_interval': 0, 01:18:15 INFO - 'suite': 'dromaeojs', 01:18:15 INFO - 'system_bits': '32', 01:18:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:18:15 INFO - 'title': 'talos-linux64-ix-030', 01:18:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:18:15 INFO - 'use_talos_json': True, 01:18:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:18:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:18:15 INFO - 'work_dir': 'build'} 01:18:15 INFO - [mozharness: 2016-08-06 08:18:15.938077Z] Running clobber step. 01:18:15 INFO - Running pre-action listener: _resource_record_pre_action 01:18:15 INFO - Running main action method: clobber 01:18:15 INFO - rmtree: /builds/slave/test/build 01:18:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:18:16 INFO - Running post-action listener: _resource_record_post_action 01:18:16 INFO - [mozharness: 2016-08-06 08:18:16.392884Z] Finished clobber step (success) 01:18:16 INFO - [mozharness: 2016-08-06 08:18:16.392985Z] Running read-buildbot-config step. 01:18:16 INFO - Running pre-action listener: _resource_record_pre_action 01:18:16 INFO - Running main action method: read_buildbot_config 01:18:16 INFO - Using buildbot properties: 01:18:16 INFO - { 01:18:16 INFO - "project": "", 01:18:16 INFO - "product": "firefox", 01:18:16 INFO - "script_repo_revision": "production", 01:18:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:18:16 INFO - "repository": "", 01:18:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:18:16 INFO - "buildid": "20160805234720", 01:18:16 INFO - "pgo_build": "False", 01:18:16 INFO - "basedir": "/builds/slave/test", 01:18:16 INFO - "buildnumber": 1855, 01:18:16 INFO - "slavename": "talos-linux64-ix-030", 01:18:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:18:16 INFO - "platform": "ubuntu64_hw", 01:18:16 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 01:18:16 INFO - "branch": "fx-team", 01:18:16 INFO - "repo_path": "integration/fx-team", 01:18:16 INFO - "revision": "115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1", 01:18:16 INFO - "stage_platform": "linux64", 01:18:16 INFO - "builduid": "bd1e2d1a71c744099ebe26d9a2d9569c", 01:18:16 INFO - "slavebuilddir": "test" 01:18:16 INFO - } 01:18:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 01:18:16 INFO - Running post-action listener: _resource_record_post_action 01:18:16 INFO - [mozharness: 2016-08-06 08:18:16.395718Z] Finished read-buildbot-config step (success) 01:18:16 INFO - [mozharness: 2016-08-06 08:18:16.395806Z] Running download-and-extract step. 01:18:16 INFO - Running pre-action listener: _resource_record_pre_action 01:18:16 INFO - Running main action method: download_and_extract 01:18:16 INFO - mkdir: /builds/slave/test/build/tests 01:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:16 INFO - trying https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:18:16 INFO - Downloading https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:18:16 INFO - Downloaded 1361 bytes. 01:18:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:18:16 INFO - Using the following test package requirements: 01:18:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:18:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:18:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:18:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'jsshell-linux-x86_64.zip'], 01:18:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:18:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:18:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:18:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:18:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:18:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:18:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:18:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:16 INFO - trying https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:18:16 INFO - Downloading https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:18:19 INFO - Downloaded 20254079 bytes. 01:18:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:18:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:18:21 INFO - Return code: 0 01:18:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:21 INFO - trying https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:18:21 INFO - Downloading https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:18:22 INFO - Downloaded 20254079 bytes. 01:18:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:18:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:18:23 INFO - Return code: 0 01:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:23 INFO - trying https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 01:18:23 INFO - Downloading https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 01:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:18:25 INFO - Downloaded 14413723 bytes. 01:18:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:18:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:18:25 INFO - Return code: 0 01:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:25 INFO - trying https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:18:25 INFO - Downloading https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:18:28 INFO - Downloaded 56130683 bytes. 01:18:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:18:28 INFO - mkdir: /builds/slave/test/properties 01:18:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:18:28 INFO - Writing to file /builds/slave/test/properties/build_url 01:18:28 INFO - Contents: 01:18:28 INFO - build_url:https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:18:29 INFO - Running post-action listener: _resource_record_post_action 01:18:29 INFO - Running post-action listener: set_extra_try_arguments 01:18:29 INFO - [mozharness: 2016-08-06 08:18:29.350206Z] Finished download-and-extract step (success) 01:18:29 INFO - [mozharness: 2016-08-06 08:18:29.350439Z] Running populate-webroot step. 01:18:29 INFO - Running pre-action listener: _resource_record_pre_action 01:18:29 INFO - Running main action method: populate_webroot 01:18:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:18:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:18:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:18:29 INFO - '--tppagecycles', 01:18:29 INFO - '7'], 01:18:29 INFO - 'tests': ['tsvgm']}}, 01:18:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:18:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:18:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:18:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:18:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['damp', 'tps']}, 01:18:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'tests': ['damp', 'tps']}, 01:18:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['dromaeo_dom']}, 01:18:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:18:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['basic_compositor_video']}, 01:18:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:18:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['a11yr', 01:18:29 INFO - 'ts_paint', 01:18:29 INFO - 'tpaint', 01:18:29 INFO - 'sessionrestore', 01:18:29 INFO - 'sessionrestore_no_auto_restore', 01:18:29 INFO - 'tabpaint']}, 01:18:29 INFO - 'other-e10s': {'tests': ['a11yr', 01:18:29 INFO - 'ts_paint', 01:18:29 INFO - 'tpaint', 01:18:29 INFO - 'sessionrestore', 01:18:29 INFO - 'sessionrestore_no_auto_restore', 01:18:29 INFO - 'tabpaint']}, 01:18:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:18:29 INFO - 'ts_paint', 01:18:29 INFO - 'tpaint', 01:18:29 INFO - 'sessionrestore', 01:18:29 INFO - 'sessionrestore_no_auto_restore', 01:18:29 INFO - 'tabpaint']}, 01:18:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:18:29 INFO - 'ts_paint', 01:18:29 INFO - 'tpaint', 01:18:29 INFO - 'sessionrestore', 01:18:29 INFO - 'sessionrestore_no_auto_restore', 01:18:29 INFO - 'tabpaint']}, 01:18:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['a11yr', 01:18:29 INFO - 'ts_paint', 01:18:29 INFO - 'tpaint', 01:18:29 INFO - 'sessionrestore', 01:18:29 INFO - 'sessionrestore_no_auto_restore', 01:18:29 INFO - 'tabpaint']}, 01:18:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['a11yr', 01:18:29 INFO - 'ts_paint', 01:18:29 INFO - 'tpaint', 01:18:29 INFO - 'sessionrestore', 01:18:29 INFO - 'sessionrestore_no_auto_restore', 01:18:29 INFO - 'tabpaint']}, 01:18:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['tsvgx', 01:18:29 INFO - 'tsvgr_opacity', 01:18:29 INFO - 'tart', 01:18:29 INFO - 'tscrollx', 01:18:29 INFO - 'cart']}, 01:18:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:18:29 INFO - 'tsvgr_opacity', 01:18:29 INFO - 'tart', 01:18:29 INFO - 'tscrollx', 01:18:29 INFO - 'cart']}, 01:18:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'talos_options': ['--disable-e10s'], 01:18:29 INFO - 'tests': ['tp5o']}, 01:18:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'tests': ['tp5o']}, 01:18:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'talos_options': ['--disable-e10s', 01:18:29 INFO - '--xperf_path', 01:18:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:29 INFO - 'tests': ['tp5n']}, 01:18:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:29 INFO - 'talos_options': ['--xperf_path', 01:18:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:29 INFO - 'tests': ['tp5n']}}, 01:18:29 INFO - 'talos.zip': {'path': '', 01:18:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:18:29 INFO - Running post-action listener: _resource_record_post_action 01:18:29 INFO - [mozharness: 2016-08-06 08:18:29.365580Z] Finished populate-webroot step (success) 01:18:29 INFO - [mozharness: 2016-08-06 08:18:29.365669Z] Running create-virtualenv step. 01:18:29 INFO - Running pre-action listener: _resource_record_pre_action 01:18:29 INFO - Running main action method: create_virtualenv 01:18:29 INFO - Creating virtualenv /builds/slave/test/build/venv 01:18:29 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 01:18:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:18:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:18:29 INFO - Using real prefix '/usr' 01:18:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:18:29 INFO - Installing distribute.............................................................................................................................................................................................done. 01:18:31 INFO - Installing pip.................done. 01:18:31 INFO - Return code: 0 01:18:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:31 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:31 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 01:18:31 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 01:18:31 INFO - Using env: {'DISPLAY': ':0', 01:18:31 INFO - 'HOME': '/home/cltbld', 01:18:31 INFO - 'LANG': 'en_US.UTF-8', 01:18:31 INFO - 'LANGUAGE': 'en_US:en', 01:18:31 INFO - 'LOGNAME': 'cltbld', 01:18:31 INFO - 'MAIL': '/var/mail/cltbld', 01:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:31 INFO - 'MOZ_NO_REMOTE': '1', 01:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:31 INFO - 'NO_EM_RESTART': '1', 01:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:31 INFO - 'PWD': '/builds/slave/test', 01:18:31 INFO - 'SHELL': '/bin/bash', 01:18:31 INFO - 'SHLVL': '1', 01:18:31 INFO - 'TERM': 'linux', 01:18:31 INFO - 'TMOUT': '86400', 01:18:31 INFO - 'USER': 'cltbld', 01:18:31 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:31 INFO - '_': '/tools/buildbot/bin/python'} 01:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:18:32 INFO - Cleaning up... 01:18:32 INFO - Return code: 0 01:18:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:18:32 INFO - Using env: {'DISPLAY': ':0', 01:18:32 INFO - 'HOME': '/home/cltbld', 01:18:32 INFO - 'LANG': 'en_US.UTF-8', 01:18:32 INFO - 'LANGUAGE': 'en_US:en', 01:18:32 INFO - 'LOGNAME': 'cltbld', 01:18:32 INFO - 'MAIL': '/var/mail/cltbld', 01:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:32 INFO - 'MOZ_NO_REMOTE': '1', 01:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:32 INFO - 'NO_EM_RESTART': '1', 01:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:32 INFO - 'PWD': '/builds/slave/test', 01:18:32 INFO - 'SHELL': '/bin/bash', 01:18:32 INFO - 'SHLVL': '1', 01:18:32 INFO - 'TERM': 'linux', 01:18:32 INFO - 'TMOUT': '86400', 01:18:32 INFO - 'USER': 'cltbld', 01:18:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:32 INFO - '_': '/tools/buildbot/bin/python'} 01:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:32 INFO - Downloading/unpacking psutil>=3.1.1 01:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:18:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:18:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:18:34 INFO - Installing collected packages: psutil 01:18:34 INFO - Running setup.py install for psutil 01:18:34 INFO - building 'psutil._psutil_linux' extension 01:18:34 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 01:18:34 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 01:18:34 INFO - building 'psutil._psutil_posix' extension 01:18:34 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 01:18:34 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 01:18:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:18:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:18:34 INFO - Successfully installed psutil 01:18:34 INFO - Cleaning up... 01:18:34 INFO - Return code: 0 01:18:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:34 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:34 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 01:18:34 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 01:18:34 INFO - Using env: {'DISPLAY': ':0', 01:18:34 INFO - 'HOME': '/home/cltbld', 01:18:34 INFO - 'LANG': 'en_US.UTF-8', 01:18:34 INFO - 'LANGUAGE': 'en_US:en', 01:18:34 INFO - 'LOGNAME': 'cltbld', 01:18:34 INFO - 'MAIL': '/var/mail/cltbld', 01:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:34 INFO - 'MOZ_NO_REMOTE': '1', 01:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:34 INFO - 'NO_EM_RESTART': '1', 01:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:34 INFO - 'PWD': '/builds/slave/test', 01:18:34 INFO - 'SHELL': '/bin/bash', 01:18:34 INFO - 'SHLVL': '1', 01:18:34 INFO - 'TERM': 'linux', 01:18:34 INFO - 'TMOUT': '86400', 01:18:34 INFO - 'USER': 'cltbld', 01:18:34 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:34 INFO - '_': '/tools/buildbot/bin/python'} 01:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:18:37 INFO - Installing collected packages: mozsystemmonitor 01:18:37 INFO - Running setup.py install for mozsystemmonitor 01:18:37 INFO - Successfully installed mozsystemmonitor 01:18:37 INFO - Cleaning up... 01:18:37 INFO - Return code: 0 01:18:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:37 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:37 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 01:18:37 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 01:18:37 INFO - Using env: {'DISPLAY': ':0', 01:18:37 INFO - 'HOME': '/home/cltbld', 01:18:37 INFO - 'LANG': 'en_US.UTF-8', 01:18:37 INFO - 'LANGUAGE': 'en_US:en', 01:18:37 INFO - 'LOGNAME': 'cltbld', 01:18:37 INFO - 'MAIL': '/var/mail/cltbld', 01:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:37 INFO - 'MOZ_NO_REMOTE': '1', 01:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:37 INFO - 'NO_EM_RESTART': '1', 01:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:37 INFO - 'PWD': '/builds/slave/test', 01:18:37 INFO - 'SHELL': '/bin/bash', 01:18:37 INFO - 'SHLVL': '1', 01:18:37 INFO - 'TERM': 'linux', 01:18:37 INFO - 'TMOUT': '86400', 01:18:37 INFO - 'USER': 'cltbld', 01:18:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:37 INFO - '_': '/tools/buildbot/bin/python'} 01:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:37 INFO - Downloading/unpacking jsonschema==2.5.1 01:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:18:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:18:39 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 01:18:39 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 01:18:39 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 01:18:39 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 01:18:39 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 01:18:39 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 01:18:39 INFO - Downloading functools32-3.2.3-2.tar.gz 01:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:18:39 INFO - warning: no files found matching '*.txt' 01:18:39 INFO - no previously-included directories found matching 'build' 01:18:39 INFO - no previously-included directories found matching 'dist' 01:18:39 INFO - no previously-included directories found matching '.git*' 01:18:39 INFO - Installing collected packages: jsonschema, functools32 01:18:39 INFO - Running setup.py install for functools32 01:18:39 INFO - warning: no files found matching '*.txt' 01:18:39 INFO - no previously-included directories found matching 'build' 01:18:39 INFO - no previously-included directories found matching 'dist' 01:18:39 INFO - no previously-included directories found matching '.git*' 01:18:39 INFO - Successfully installed jsonschema functools32 01:18:39 INFO - Cleaning up... 01:18:39 INFO - Return code: 0 01:18:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:18:39 INFO - Using env: {'DISPLAY': ':0', 01:18:39 INFO - 'HOME': '/home/cltbld', 01:18:39 INFO - 'LANG': 'en_US.UTF-8', 01:18:39 INFO - 'LANGUAGE': 'en_US:en', 01:18:39 INFO - 'LOGNAME': 'cltbld', 01:18:39 INFO - 'MAIL': '/var/mail/cltbld', 01:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:39 INFO - 'MOZ_NO_REMOTE': '1', 01:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:39 INFO - 'NO_EM_RESTART': '1', 01:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:39 INFO - 'PWD': '/builds/slave/test', 01:18:39 INFO - 'SHELL': '/bin/bash', 01:18:39 INFO - 'SHLVL': '1', 01:18:39 INFO - 'TERM': 'linux', 01:18:39 INFO - 'TMOUT': '86400', 01:18:39 INFO - 'USER': 'cltbld', 01:18:39 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:39 INFO - '_': '/tools/buildbot/bin/python'} 01:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:18:39 INFO - Cleaning up... 01:18:39 INFO - Return code: 0 01:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:39 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:39 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 01:18:39 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 01:18:39 INFO - Using env: {'DISPLAY': ':0', 01:18:39 INFO - 'HOME': '/home/cltbld', 01:18:39 INFO - 'LANG': 'en_US.UTF-8', 01:18:39 INFO - 'LANGUAGE': 'en_US:en', 01:18:39 INFO - 'LOGNAME': 'cltbld', 01:18:39 INFO - 'MAIL': '/var/mail/cltbld', 01:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:39 INFO - 'MOZ_NO_REMOTE': '1', 01:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:39 INFO - 'NO_EM_RESTART': '1', 01:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:39 INFO - 'PWD': '/builds/slave/test', 01:18:39 INFO - 'SHELL': '/bin/bash', 01:18:39 INFO - 'SHLVL': '1', 01:18:39 INFO - 'TERM': 'linux', 01:18:39 INFO - 'TMOUT': '86400', 01:18:39 INFO - 'USER': 'cltbld', 01:18:39 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:39 INFO - '_': '/tools/buildbot/bin/python'} 01:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:40 INFO - Downloading/unpacking blobuploader==1.2.4 01:18:40 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 01:18:40 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 01:18:40 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 01:18:40 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 01:18:40 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 01:18:40 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 01:18:42 INFO - Downloading blobuploader-1.2.4.tar.gz 01:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:18:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:18:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:42 INFO - Downloading docopt-0.6.1.tar.gz 01:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:18:42 INFO - Installing collected packages: blobuploader, requests, docopt 01:18:42 INFO - Running setup.py install for blobuploader 01:18:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:18:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:18:42 INFO - Running setup.py install for requests 01:18:43 INFO - Running setup.py install for docopt 01:18:43 INFO - Successfully installed blobuploader requests docopt 01:18:43 INFO - Cleaning up... 01:18:43 INFO - Return code: 0 01:18:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:43 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:43 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 01:18:43 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 01:18:43 INFO - Using env: {'DISPLAY': ':0', 01:18:43 INFO - 'HOME': '/home/cltbld', 01:18:43 INFO - 'LANG': 'en_US.UTF-8', 01:18:43 INFO - 'LANGUAGE': 'en_US:en', 01:18:43 INFO - 'LOGNAME': 'cltbld', 01:18:43 INFO - 'MAIL': '/var/mail/cltbld', 01:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:43 INFO - 'MOZ_NO_REMOTE': '1', 01:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:43 INFO - 'NO_EM_RESTART': '1', 01:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:43 INFO - 'PWD': '/builds/slave/test', 01:18:43 INFO - 'SHELL': '/bin/bash', 01:18:43 INFO - 'SHLVL': '1', 01:18:43 INFO - 'TERM': 'linux', 01:18:43 INFO - 'TMOUT': '86400', 01:18:43 INFO - 'USER': 'cltbld', 01:18:43 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:43 INFO - '_': '/tools/buildbot/bin/python'} 01:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:18:43 INFO - Running setup.py (path:/tmp/pip-w7nRip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:18:43 INFO - Running setup.py (path:/tmp/pip-DZUeuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:18:43 INFO - Running setup.py (path:/tmp/pip-2XbuZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:18:43 INFO - Running setup.py (path:/tmp/pip-w2hE_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:18:43 INFO - Running setup.py (path:/tmp/pip-RHs5nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:18:43 INFO - Running setup.py (path:/tmp/pip-Be4QX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:18:44 INFO - Running setup.py (path:/tmp/pip-94pEc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:18:44 INFO - Running setup.py (path:/tmp/pip-pwTjwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:18:44 INFO - Running setup.py (path:/tmp/pip-MiA21p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:18:44 INFO - Running setup.py (path:/tmp/pip-xxlJWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:18:44 INFO - Running setup.py (path:/tmp/pip-Ky6zSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:18:44 INFO - Running setup.py (path:/tmp/pip-EWJWxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:18:44 INFO - Running setup.py (path:/tmp/pip-Y9i8nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:18:44 INFO - Running setup.py (path:/tmp/pip-zxgpv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:44 INFO - Running setup.py (path:/tmp/pip-1OulhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:18:44 INFO - Running setup.py (path:/tmp/pip-S2i8nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:18:44 INFO - Running setup.py (path:/tmp/pip-9W1t7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:18:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:18:44 INFO - Running setup.py install for manifestparser 01:18:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:18:44 INFO - Running setup.py install for mozcrash 01:18:45 INFO - Running setup.py install for mozdebug 01:18:45 INFO - Running setup.py install for mozdevice 01:18:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Running setup.py install for mozfile 01:18:45 INFO - Running setup.py install for mozhttpd 01:18:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Running setup.py install for mozinfo 01:18:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Running setup.py install for mozInstall 01:18:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Running setup.py install for mozleak 01:18:45 INFO - Running setup.py install for mozlog 01:18:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Running setup.py install for moznetwork 01:18:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:18:45 INFO - Running setup.py install for mozprocess 01:18:46 INFO - Running setup.py install for mozprofile 01:18:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Running setup.py install for mozrunner 01:18:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Running setup.py install for mozscreenshot 01:18:46 INFO - Running setup.py install for moztest 01:18:46 INFO - Running setup.py install for mozversion 01:18:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:18:46 INFO - Cleaning up... 01:18:46 INFO - Return code: 0 01:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:46 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:46 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 01:18:46 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 01:18:46 INFO - Using env: {'DISPLAY': ':0', 01:18:46 INFO - 'HOME': '/home/cltbld', 01:18:46 INFO - 'LANG': 'en_US.UTF-8', 01:18:46 INFO - 'LANGUAGE': 'en_US:en', 01:18:46 INFO - 'LOGNAME': 'cltbld', 01:18:46 INFO - 'MAIL': '/var/mail/cltbld', 01:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:46 INFO - 'MOZ_NO_REMOTE': '1', 01:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:46 INFO - 'NO_EM_RESTART': '1', 01:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:46 INFO - 'PWD': '/builds/slave/test', 01:18:46 INFO - 'SHELL': '/bin/bash', 01:18:46 INFO - 'SHLVL': '1', 01:18:46 INFO - 'TERM': 'linux', 01:18:46 INFO - 'TMOUT': '86400', 01:18:46 INFO - 'USER': 'cltbld', 01:18:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:46 INFO - '_': '/tools/buildbot/bin/python'} 01:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:18:46 INFO - Running setup.py (path:/tmp/pip-gKkR9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:18:46 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)) 01:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:18:46 INFO - Running setup.py (path:/tmp/pip-LWiMaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:18:46 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)) 01:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:18:46 INFO - Running setup.py (path:/tmp/pip-2wu5Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:18:47 INFO - Running setup.py (path:/tmp/pip-VrHNgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:18:47 INFO - Running setup.py (path:/tmp/pip-W7coWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:18:47 INFO - Running setup.py (path:/tmp/pip-AVRb5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:18:47 INFO - Running setup.py (path:/tmp/pip-m4S4su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:18:47 INFO - Running setup.py (path:/tmp/pip-YGdyhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:18:47 INFO - Running setup.py (path:/tmp/pip-f6RWyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:18:47 INFO - Running setup.py (path:/tmp/pip-IwKbPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:18:47 INFO - Running setup.py (path:/tmp/pip-AZ4HMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:18:47 INFO - Running setup.py (path:/tmp/pip-_aOob1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:18:47 INFO - Running setup.py (path:/tmp/pip-u9jpKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:18:47 INFO - Running setup.py (path:/tmp/pip-2KzfZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:47 INFO - Running setup.py (path:/tmp/pip-_WvKtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:18:47 INFO - Running setup.py (path:/tmp/pip-B0Blzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:18:47 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)) 01:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:18:47 INFO - Running setup.py (path:/tmp/pip-ZmXMD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:18:48 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)) 01:18:48 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)) 01:18:48 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)) 01:18:48 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)) 01:18:48 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)) 01:18:48 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)) 01:18:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:49 INFO - Downloading blessings-1.6.tar.gz 01:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:18:50 INFO - Installing collected packages: blessings 01:18:50 INFO - Running setup.py install for blessings 01:18:50 INFO - Successfully installed blessings 01:18:50 INFO - Cleaning up... 01:18:50 INFO - Return code: 0 01:18:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:18:50 INFO - Reading from file tmpfile_stdout 01:18:50 INFO - Current package versions: 01:18:50 INFO - argparse == 1.2.1 01:18:50 INFO - blessings == 1.6 01:18:50 INFO - blobuploader == 1.2.4 01:18:50 INFO - docopt == 0.6.1 01:18:50 INFO - functools32 == 3.2.3-2 01:18:50 INFO - jsonschema == 2.5.1 01:18:50 INFO - manifestparser == 1.1 01:18:50 INFO - mozInstall == 1.12 01:18:50 INFO - mozcrash == 0.17 01:18:50 INFO - mozdebug == 0.1 01:18:50 INFO - mozdevice == 0.48 01:18:50 INFO - mozfile == 1.2 01:18:50 INFO - mozhttpd == 0.7 01:18:50 INFO - mozinfo == 0.9 01:18:50 INFO - mozleak == 0.1 01:18:50 INFO - mozlog == 3.3 01:18:50 INFO - moznetwork == 0.27 01:18:50 INFO - mozprocess == 0.23 01:18:50 INFO - mozprofile == 0.28 01:18:50 INFO - mozrunner == 6.12 01:18:50 INFO - mozscreenshot == 0.1 01:18:50 INFO - mozsystemmonitor == 0.3 01:18:50 INFO - moztest == 0.7 01:18:50 INFO - mozversion == 1.4 01:18:50 INFO - psutil == 3.1.1 01:18:50 INFO - requests == 1.2.3 01:18:50 INFO - wsgiref == 0.1.2 01:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:50 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:50 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 01:18:50 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 01:18:50 INFO - Using env: {'DISPLAY': ':0', 01:18:50 INFO - 'HOME': '/home/cltbld', 01:18:50 INFO - 'LANG': 'en_US.UTF-8', 01:18:50 INFO - 'LANGUAGE': 'en_US:en', 01:18:50 INFO - 'LOGNAME': 'cltbld', 01:18:50 INFO - 'MAIL': '/var/mail/cltbld', 01:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:50 INFO - 'MOZ_NO_REMOTE': '1', 01:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:50 INFO - 'NO_EM_RESTART': '1', 01:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:50 INFO - 'PWD': '/builds/slave/test', 01:18:50 INFO - 'SHELL': '/bin/bash', 01:18:50 INFO - 'SHLVL': '1', 01:18:50 INFO - 'TERM': 'linux', 01:18:50 INFO - 'TMOUT': '86400', 01:18:50 INFO - 'USER': 'cltbld', 01:18:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:50 INFO - '_': '/tools/buildbot/bin/python'} 01:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 INFO - Cleaning up... 01:18:50 INFO - Return code: 0 01:18:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:50 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 0x1e1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, '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': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', '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 01:18:50 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 01:18:50 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 01:18:50 INFO - Using env: {'DISPLAY': ':0', 01:18:50 INFO - 'HOME': '/home/cltbld', 01:18:50 INFO - 'LANG': 'en_US.UTF-8', 01:18:50 INFO - 'LANGUAGE': 'en_US:en', 01:18:50 INFO - 'LOGNAME': 'cltbld', 01:18:50 INFO - 'MAIL': '/var/mail/cltbld', 01:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:50 INFO - 'MOZ_NO_REMOTE': '1', 01:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:18:50 INFO - 'NO_EM_RESTART': '1', 01:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:50 INFO - 'PWD': '/builds/slave/test', 01:18:50 INFO - 'SHELL': '/bin/bash', 01:18:50 INFO - 'SHLVL': '1', 01:18:50 INFO - 'TERM': 'linux', 01:18:50 INFO - 'TMOUT': '86400', 01:18:50 INFO - 'USER': 'cltbld', 01:18:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:50 INFO - '_': '/tools/buildbot/bin/python'} 01:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:18:50 INFO - Cleaning up... 01:18:50 INFO - Return code: 0 01:18:50 INFO - Running post-action listener: _resource_record_post_action 01:18:50 INFO - Running post-action listener: _start_resource_monitoring 01:18:50 INFO - Starting resource monitoring. 01:18:50 INFO - [mozharness: 2016-08-06 08:18:50.864261Z] Finished create-virtualenv step (success) 01:18:50 INFO - [mozharness: 2016-08-06 08:18:50.864744Z] Running install step. 01:18:50 INFO - Running pre-action listener: _resource_record_pre_action 01:18:50 INFO - Running main action method: install 01:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:18:51 INFO - Reading from file tmpfile_stdout 01:18:51 INFO - Detecting whether we're running mozinstall >=1.0... 01:18:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:18:51 INFO - Reading from file tmpfile_stdout 01:18:51 INFO - Output received: 01:18:51 INFO - Usage: mozinstall [options] installer 01:18:51 INFO - Options: 01:18:51 INFO - -h, --help show this help message and exit 01:18:51 INFO - -d DEST, --destination=DEST 01:18:51 INFO - Directory to install application into. [default: 01:18:51 INFO - "/builds/slave/test"] 01:18:51 INFO - --app=APP Application being installed. [default: firefox] 01:18:51 INFO - mkdir: /builds/slave/test/build/application 01:18:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:19:07 INFO - Reading from file tmpfile_stdout 01:19:07 INFO - Output received: 01:19:07 INFO - /builds/slave/test/build/application/firefox/firefox 01:19:07 INFO - Running post-action listener: _resource_record_post_action 01:19:07 INFO - [mozharness: 2016-08-06 08:19:07.338903Z] Finished install step (success) 01:19:07 INFO - [mozharness: 2016-08-06 08:19:07.339241Z] Running run-tests step. 01:19:07 INFO - Running pre-action listener: _resource_record_pre_action 01:19:07 INFO - Running main action method: run_tests 01:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:19:07 INFO - Python 2.7.3 01:19:07 INFO - Return code: 0 01:19:07 INFO - grabbing minidump binary from tooltool 01:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:07 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 0x20de3b0>, '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 0x20df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20df740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:19:07 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 01:19:07 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 01:19:07 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 01:19:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:19:07 INFO - Return code: 0 01:19:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:19:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:19:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:19:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:19:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 01:19:07 INFO - Using env: {'DISPLAY': ':0', 01:19:07 INFO - 'HOME': '/home/cltbld', 01:19:07 INFO - 'LANG': 'en_US.UTF-8', 01:19:07 INFO - 'LANGUAGE': 'en_US:en', 01:19:07 INFO - 'LOGNAME': 'cltbld', 01:19:07 INFO - 'MAIL': '/var/mail/cltbld', 01:19:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:19:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:07 INFO - 'MOZ_NO_REMOTE': '1', 01:19:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:07 INFO - 'NO_EM_RESTART': '1', 01:19:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:07 INFO - 'PWD': '/builds/slave/test', 01:19:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:19:07 INFO - 'SHELL': '/bin/bash', 01:19:07 INFO - 'SHLVL': '1', 01:19:07 INFO - 'TERM': 'linux', 01:19:07 INFO - 'TMOUT': '86400', 01:19:07 INFO - 'USER': 'cltbld', 01:19:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553', 01:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:07 INFO - '_': '/tools/buildbot/bin/python'} 01:19:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:19:07 INFO - mozversion application_buildid: 20160805234720 01:19:07 INFO - mozversion application_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 01:19:07 INFO - mozversion application_display_name: Nightly 01:19:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:19:07 INFO - mozversion application_name: Firefox 01:19:07 INFO - mozversion application_remotingname: firefox 01:19:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:19:07 INFO - mozversion application_vendor: Mozilla 01:19:07 INFO - mozversion application_version: 51.0a1 01:19:07 INFO - mozversion platform_buildid: 20160805234720 01:19:07 INFO - mozversion platform_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 01:19:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:19:07 INFO - mozversion platform_version: 51.0a1 01:19:07 INFO - using testdate: 1470471547 01:19:07 INFO - actual date: 1470471547 01:19:07 INFO - starting webserver on 'localhost:32826' 01:19:07 INFO - SUITE-START | Running 2 tests 01:19:07 INFO - TEST-START | dromaeo_css 01:19:07 INFO - operating with platform_type : linux_ 01:19:07 INFO - Initialising browser for dromaeo_css test... 01:19:07 INFO - TEST-INFO | started process 28064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1xuaHU/profile http://localhost:32826/getInfo.html) 01:19:11 INFO - PROCESS | 28064 | __metrics Screen width/height:1600/1200 01:19:11 INFO - PROCESS | 28064 | colorDepth:24 01:19:11 INFO - PROCESS | 28064 | Browser inner width/height: 1024/697 01:19:11 INFO - PROCESS | 28064 | __metrics 01:19:12 INFO - PROCESS | 28064 | 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" 01:19:12 INFO - PROCESS | 28064 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:19:13 INFO - TEST-INFO | 28064: exit 0 01:19:13 INFO - Browser initialized. 01:19:13 INFO - Running cycle 1/1 for dromaeo_css test... 01:19:13 INFO - TEST-INFO | started process 28144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1xuaHU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:19:25 INFO - PROCESS | 28144 | RSS: Main: 157958144 01:19:25 INFO - PROCESS | 28144 | 01:20:16 INFO - PROCESS | 28144 | 1470471616884 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] 01:22:28 INFO - PROCESS | 28144 | Cycle 1(1): loaded http://localhost:32826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32826/tests/dromaeo/cssquery-ext.html) 01:22:30 INFO - PROCESS | 28144 | RSS: Main: 273158144 01:22:30 INFO - PROCESS | 28144 | 01:25:32 INFO - PROCESS | 28144 | Cycle 1(1): loaded http://localhost:32826/tests/dromaeo/cssquery-ext.html (next: http://localhost:32826/tests/dromaeo/cssquery-jquery.html) 01:25:33 INFO - PROCESS | 28144 | RSS: Main: 236261376 01:25:33 INFO - PROCESS | 28144 | 01:28:35 INFO - PROCESS | 28144 | Cycle 1(1): loaded http://localhost:32826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32826/tests/dromaeo/cssquery-mootools.html) 01:28:36 INFO - PROCESS | 28144 | RSS: Main: 184922112 01:28:36 INFO - PROCESS | 28144 | 01:31:38 INFO - PROCESS | 28144 | Cycle 1(1): loaded http://localhost:32826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32826/tests/dromaeo/cssquery-prototype.html) 01:31:38 INFO - PROCESS | 28144 | RSS: Main: 185188352 01:31:38 INFO - PROCESS | 28144 | 01:34:42 INFO - PROCESS | 28144 | Cycle 1(1): loaded http://localhost:32826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32826/tests/dromaeo/cssquery-yui.html) 01:34:42 INFO - PROCESS | 28144 | RSS: Main: 187555840 01:34:42 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | Cycle 1(1): loaded http://localhost:32826/tests/dromaeo/cssquery-yui.html (next: http://localhost:32826/tests/dromaeo/cssquery-dojo.html) 01:37:45 INFO - PROCESS | 28144 | RSS: Main: 231223296 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | __start_tp_report 01:37:45 INFO - PROCESS | 28144 | _x_x_mozilla_page_load 01:37:45 INFO - PROCESS | 28144 | _x_x_mozilla_page_load_details 01:37:45 INFO - PROCESS | 28144 | |i|pagename|runs| 01:37:45 INFO - PROCESS | 28144 | |0;dojo.html;2564.051301018623;2581.070814506776;2616.4897844920242;2630.644862943502;2631.815772895896;4389.188000219961;4487.439070116236;4538.7276763394175;4598.402207712997;4605.378273933014;4462.286034234523;4481.686281960264;4555.385023021891;4611.146937816507;4634.189016922033;4167.9583204167875;4189.706720529564;4225.408442818016;4235.851745188919;4301.849435269766;4256.106217694288;4290.292101803198;4334.133173365324;4368.279233926399;4374.4313239278845;4275.8075886585175;4333.544977777336;4341.804618792162;4347.60871521563;4379.934300985487;4123.484564429446;4163.875083747493;4164.895877603054;4193.224253513079;4244.342126970325;4180.226658068267;4182.100848317596;4214.641755450791;4225.3873188387515;4271.9359209611885;4586.610138138262;4591.288350305708;4591.908161836778;4603.171429142753;4615.100055489181;4768.856934291976;4844.63665225106;4928.33467481889;4929;4933.950660493385;4910.386201724785;4943.604511639061;4946.579540739005;4947.752612369403;4950.232713929347;4549.385832912514;4556.908861822745;4597.034622729231;4604.010137820384;4610.377599024156;4881.926771098437;4930.359053323117;5005.424376196711;5039.420466646309;5049.2173713074535;4852.975735121372;4868.318435419044;4869.001854619865;4888.437829649636;4893.486183950705;4876;4898.853034408973;4913.852584422473;4921.532454416824;4924.8276310328965;4736.478987311393;4844.95155048452;4852.660313778002;4859.538343857328;4898.779554920037;4774;4843.07981483517;4844.0554091951735;4845.563899249085;4888.608911287089;4153.979230103891;4158.022864626811;4177.185448837447;4192.182524407772;4207.431996680409;3656.9634303657153;3676.2279921216846;3677.3196958562216;3708.610595887447;3740.139767853409;4101.405296232029;4176.206520761046;4220.240356735756;4245.299525578245;4252.128313695685;4906.31311616374;4912.533309335608;4916.262560615936;4951.034548263126;4958.132326842788;4170.082581831992;4186.937195942063;4192.4759405074365;4232.32282834745;4233.364995250737;4227.260229459832;4397.560243975641;4398.340248962617;4404.559544045634;4431.711938723973;4652.464966528893;4674.415698037746;4676.392069031004;4711.57595816385;4722.456917454537;4952.678075925053;4952.752362381939;4953.331300274417;4955.479674634112;4995.450500444876;4472.284434490466;4570.657200709894;4588.655850811136;4675.181843177498;4705.247160454311;4815.927761083657;4831.275308703582;4833.250846118857;4862.270659401118;4878.463369029333;4886.828960986349;4887.706737595756;4890.2909078184175;4893.632977526771;4928.457869634409;4615.169269531382;4687.039156972744;4698.271767875985;4751.83368582098;4791.904161916673;4738;4759.524047595212;4762.214234651244;4791.736454495036;4814;4694.366260554782;4735.21868891629;4737.336772851734;4737.739424331557;4748.857534273978;4655.883602909955;4687.250039993584;4750.216214324598;4765.237561990065;4777.737224452689;4669.509701481432;4690.577847993697;4693.319468676955;4719.197736384892;4734 01:37:45 INFO - PROCESS | 28144 | |1;ext.html;551.1377056924651;576.2940398012436;579.1284117403308;581.380829416671;592.4164697772693;28750.281242968937;31368.05895823123;31606.525902111487;31635.525467117954;31724;39124.41313380295;39978.20043599126;40057.59942400575;44583.55416445834;44693.77653111738;7730.884036739468;7882.290593846553;7903.8419231615335;7916.485428447132;7921.08907475639;7556.168821429638;7638.770836874903;7639.9236007639765;7641.4268929830205;7641.961790191069;7671.079470463552;7674.040744906887;7693.192214817447;7696.345810606077;7699.114601820778;7635.121960974503;7673.769786906401;7677.961610191969;7682.692692292301;7694.499857509244;7703.653335599912;7748.845023099507;7769.494982826155;7771.300582947505;7771.689132434696;39091.60908390908;39405.802970984965;39456;39529.40705889414;39542.802285988386;2957.8373189474787;2977.330100727341;3086.9536956945662;3137.356841847439;3204.1829333519804;29479.557806632918;30491.695083049108;30689.539656905163;30874.382512349628;30900.845495772377;3211.2935154266024;3224.3067740435918;3241.8379081045855;3376.5441665375106;3382.0699307690584;258501.70749146322;259456;260293;261171;261929;32235.516467253008;54167;54296.45703542993;54531.454685453435;54539.72730136324;32210.19474513156;34479.827600861834;34546.309073818884;34557.481637775454;34567.65432345695;13321.467141314239;13540.932295338658;13542.322883855768;13546.119502232323;13556.11885227457;10727.195460340507;10764.246502744889;10801.405922674172;10829.566817327219;10835.729106772395;7914.643841027168;7930.920690793134;7959.761207163794;7989.680412783539;8016.398770092266;3134.6081739782526;3142.8742850285735;3168.651448340681;3168.66728993457;3196.280836811699;795.677750511044;846.4921047371528;919.1865199298535;927.9953600231955;984.6504490905626;28193.295167620563;28242.2939426516;28788;28813.85593072063;28892;752.236479972828;911.4075850696968;911.7355966769695;913.4062859141478;958.3483231402713;14475.638109047359;15410;15478.845211547965;15579;15605.68788624221;382958;383075;384028;384087;384448;50502.939647242565;50962.23556646653;50986.74506627443;51005.74497127565;51064.74467627712;1015.4262841494532;1072.5334479501441;1075.8386242063596;1138.7893239750672;1153.9826902596467;20283;30039.69960300369;30427;30495;30657.386852263277;42943.355849662905;43446.78276608597;43498.782506087264;43519.12961740811;43576.782116090486;284140;285523;285955;286179;286297;25185.74814251834;25549.489010220062;26252.73747262503;26311.21066368012;27562.5865612012;43429.78285108554;43573;43576.56423435852;43664;44959.32561011653;36581.08547286339;36633.816830915675;36997.31903485272;37040.25919481649;37573.24853502969;36364.27271454609;37122.62877371192;37240;37298.627013729514;37768.43347349737;31405.214869628442;31487.37025259528;32122.518162228054;32206.67793322037;32406.51390229101;31385.686143139188;33840.83079584586;34034.82982585071;34091;34208;24993.87503062473;26997.46005079848;27307.453850923266;27480.58779118355;27746.306342341602 01:37:45 INFO - PROCESS | 28144 | |2;jquery.html;344.9862005519776;370.09511743786436;378.48148037189037;378.79734342126966;394.1506054452654;12872.227666340026;16258.34966601336;16514.834851651496;16956;17929.01390423526;16926.74609880853;17394;17559.561010974732;17723.379681711143;17953.64092718145;5099.643024988243;6508.47932165428;6785.2196997345445;6819.659017049153;6824.454043676494;4000.2399544086675;6562.3765742254645;6774.220964589086;6829.658517074151;6833.145856767904;6836.248012718622;6836.726530938757;6973.895391569131;6975.2675969023285;6991.091158149434;6719.798406047802;6842.418394436479;6869.7595584154815;6880.862382752317;6881.174259088892;6212;6488.480921526267;6673.165854268216;6675.332466753334;6675.365840245169;24052.51894962091;24130.155444559357;24271.878640606683;24333.513329733305;24532.264032079067;1892.9337473188373;2077.574097310048;2268.7164104486938;2615.6207349934343;2660.148752399233;14122;14693.632659183499;14769.409223631043;14815.481458148914;15689.058656480647;1874;1897.1368027547433;1923.6729755941524;1924.2976313645559;1997.460685614876;81562;84859.15140848575;85800;86333.56833215857;89668;16198.838011619733;16406;16459.670806583803;16808.495745127664;16942.322307107825;29532.704672952994;29545.704542954725;29638.851805740833;29720.851395742884;29767.702322976926;8875.600597973107;9248.583813728399;9409.482478463613;9494.477803720862;9537.093976072261;7693.422993275415;7744.574048427278;7801.375889928792;7987.1214166442805;7989.960050199712;8128.349732021424;8159.632816523152;8440.957795210985;8548.914510854936;8590.661715833588;3084.7994880333154;3105.736012438968;3294.374068926896;3333.448940460699;3354.5471361365903;654.3489228217953;682.2018238660779;710.9608971506617;849.3757088539918;860.324645153564;15429.228538573027;15588.610284742745;16167.191640418167;16244.51266462008;16703.498895033168;746.6154930210946;767.1369709077288;850.7277671145174;866.8049688819965;908.7591788176138;6532.8040158794365;8825.205731484197;8841.778955526035;9054.592543335566;9492.857607135898;309703;311908;313019;394738;397090;84228.57885710655;85343.57328213319;85973.57013215018;86407;86605;929.4051806843626;944.8488241881404;963.2294164668237;964.3249725192253;979.24108815667;15486.148261845707;15661.373545058526;16005.759913601072;16334.428295009619;16396.83603163953;36330.27339453143;36891.44662830006;36993.81503092467;39634.207315852946;39919.401208981304;51638.22542661788;52144.478555213966;53213.4678653224;54455.72772136114;54978.725106374215;6933.861322773415;7148.85702285941;7292.525985811118;7321.986453725268;7617.085949685851;10637.787244254916;10912.181586380895;11004.119670426508;11181;11275.003847700551;9327.720168394959;9637.566309515949;9803.705888823346;10029.749256268651;10292.948535257576;9253.53732313395;9530;9882.25883058759;10136.138428233682;10439.060484556427;9199.724008279762;9391.671291504765;9473.957864634747;9931.404115753077;10075.949620251851;7488.326050655467;7685.615719214129;7695.807604809925;7780.610969451618;7802.843943121219;7656.6554505048525;9768.511574421393;10045.547950342398;10103.848442273518;10578.15374770032 01:37:45 INFO - PROCESS | 28144 | |3;mootools.html;1346.6027521881042;1396.97904531432;1453.6583902782845;1638.1154176744558;1683.0322564525402;7519.473636845416;8097.14979927108;8098.311643510308;8126.268635822775;8130.186981301867;6777.457803375731;7227.89158162628;7488.475806693534;7498.250174982512;7911.287984081431;2053.178728508601;2104.284543255293;2112.8943552822375;2114.3656902929138;2116.5449428372895;1985.6525108106096;2001.3095482058739;2013.9798602014012;2030.0763152765455;2033.6949457581334;1737.5742942978989;2062.9994452690507;2072.492239401349;2154.5906277807244;2155.8059774620283;2116.4179850541072;2139.6255655260425;2140.5825863956534;2142.389419015581;2143.8070573648447;2071.968920466194;2137.850350475467;2141.4325203821;2143.046344376753;2144.8069673729437;7845.215478452166;7893.447458677895;7898.644560994769;7901.09137449195;7906.486078404942;4285.142971405731;4466.486354069291;4471.709338892962;4472.396226509412;4472.731636101845;2747.175847245838;2811.5501519756945;2844;2852.6148969889214;2853.5576985567272;817.6443247187433;835.5613303015965;839.8236370362231;848.9066202717696;853.4239388412797;10475.528601212887;10670;10695.465226738632;10711;10726.892731072667;3985.880423587297;4062.614051665087;4197;4273.1240095780295;4287.442632457823;9117.133872282122;9127;9160;9190.90809091914;9204.309676774268;4485.798139083749;4560.361549383089;4579.931301030487;4589.036302376471;4595.632349412039;3953.5453422856162;4119.299719047769;4128.091819799639;4128.896777580524;4133.297339452301;3497.405441075023;3556.270964452281;3613.3676606594267;3634.454831775202;3639.417693169133;1022.9744256393501;1028.6296933104077;1039.2465462539599;1047.3349423116224;1048.3500229857536;783.7217787685404;810.7973006748313;812.6180695073306;819.4141189049858;820.2003047029218;4980.302757613937;5030.874228144326;5080.288759573588;5152.639315247971;5175.611829112831;379.45358683496227;383.54549858417863;385.7107169622783;389.2895465774972;393.8247479871487;3631.727620428426;3687.188818459988;3693.978546929204;3696.482492451059;3766.7739935603404;8995.730128096167;9458.763530911645;9461.716148515556;9462.858057129148;9477.763055923657;9441.291903107294;9453.76365590852;9456.479893605918;9472.621095156117;9473.100055494717;7141.357277845019;7231.517538904512;7234.348908598251;7244.38422734063;7244.746433874789;5097.133487307241;5106.719130447861;5153.922691159711;5176.7152806594495;5205.713685747321;8550.444221125606;8574.27118694893;8658.220760131619;8768;8773;8611.827763444571;8810.339224558313;8905.688300909436;8948.5078320693;8972.730818075468;6438.67806609677;6668.433183179484;6835.14560679915;6897.89653155193;7019.262977387505;7680.731174408869;7738.264864837832;7742.961285193764;7743.070831500256;7746.147923728273;6839.042534045138;6841.076454678555;6872.828179295558;6962.965185174042;7064.434845212473;6616.371444712745;6644.734210631521;6717.966410168114;6735.898961515679;6776.08522849409;6249.96875015622;6283.434490895658;6300.464460520907;6338.239411270677;6346.174997250328;4620.145273124483;4621.399218101626;4645.976770116128;4679.719216847;4922.040202160544;4506.819727210875;4562.65780066503;4662.813487460599;4674.5091765365505;4756.762161891961 01:37:45 INFO - PROCESS | 28144 | |4;prototype.html;299.7721731484072;302.68067189115476;310.14400255295385;313.1185712220102;314.1909582824228;4742.383490146281;4769.879078416569;4772.570468657825;4773.522647735224;4783.880402989927;4696.225122854725;4698.13084579353;4708.128996135709;4710.175719249126;4719.575238228567;3801.33476641588;3805.2389522095555;3807.8476860925666;3816;3823.617638236168;3460.4117300058924;3650.7627004244773;3830.9042273943237;3831.3103641344546;3833.3291673957087;3636.6181550937035;3639.5632524097146;3653.1597732521536;3657.122290650238;3663.8534458621625;3635.600083990759;3641.9453708194396;3642.1805093853936;3644.489771432002;3671.0088276165284;3107.6115485564305;3128.89048883288;3238.352329534079;3244.3997860395903;3254.5118232265113;4550.089982003613;4555.180067587833;4578.748168850712;4582.312653102028;4583.862484125481;4163.75017498951;4164.229617520768;4176.081262122329;4176.62410383064;4188.979055104735;4657.301404789275;4725.621950243973;4893.1926232171645;4893.657443978923;4933.827316043958;3519.472079188117;3523.3834079036064;3525.4006818840858;3526.435770276769;3526.642242736565;5144.948550514522;5148.304978827848;5154.639175257734;5161.354830646169;5168.61235407346;3447.1382154461385;3587.587427445825;3594.658507441789;3644.0889777555612;3649.7080233581783;3629.927401452009;3643.9089022774115;3662.8168591570316;3663.377225871608;3672.3756961316108;4130.772807495557;4137.551856850078;4142.1922725068325;4144.626983571493;4156.355764856452;4860.6111511079025;4861.781219845116;4863.805447782049;4902.730349830722;4902.950970490249;1254.2599866079056;1308.6335825968745;1320.8745169209103;1322.7751282282036;1325.4035683942266;893.8927328720465;910.4810258152921;925.1303774451993;928.6471140966524;934.0985948559537;3842.925659472411;3876.457295978565;3887.7278590498395;3887.844486220576;3908.2285594401537;4454.933176002362;4461.353103799931;4476.485204201558;4496.527864574173;4509.339489701027;3911.298585115484;3914.8434062637175;3927.2341893330527;3930.76415415076;3946.8751405849193;2290.9083636654345;2409.8433601815827;2411.385096800305;2425.830191886551;2434.9513009740062;4643.651726120487;4689.484156742756;4829.806807727722;4844.729807380075;4853.830115945995;5238.869028274324;5245.396779370421;5254.894902102013;5256.26412302278;5262.631615786935;4680.3915490985955;4804.615630749462;4856.543037088859;4860.36815214027;4869.537393947569;5056.974715126548;5057.14028615129;5071.45320677197;5075.390953085654;5083.644144909821;4997.400311962588;5000.14997450427;5000.199968005102;5007.29897814299;5038.647294689483;4562.5665561771575;4768.499307572793;4796.832110876103;4800.687955282895;4811.879703007313;3604.7116230702004;3608.1340478285547;3632.255387645579;3635.5092062571216;3651.7808931464197;5052.393712754493;5069.8732531687;5084.2627818966785;5106.106431374569;5115.948840511547;4952.455229924633;4981.775820088033;4982.128127577732;4995.575376093073;5003.449620541664;4694.6244300456565;4915.926261106158;4941.481144479922;4946.62900282473;4966.056449274626;4847.830325938575;4858.271259311132;4867.70793752376;4896.2655601660035;4896.6572339935865;4879.365682461257;5003;5018.67005243618;5021.221710634857;5033.723145226902;4813.614910807057;4825.9865428260455;4856.902861942671;4859.392575928009;4894.33926419943 01:37:45 INFO - PROCESS | 28144 | |5;yui.html;596.7255062671171;608.479749813909;648.3840351665916;649.0426620734415;664.9002649602562;12481.188722733028;13357.131786433874;13539.458421663121;13661.590152295435;13840.377183026763;12350.752984940296;12411.379431028457;12419.689507762288;12432.316222607753;12437.62687119388;639.1882309466974;770.7533589251427;788.4835432791502;788.4993029426327;790.1742678900534;762.7139822566537;785.4344871692373;785.8153333966513;792.8969233999601;794.0788685125256;819.6885183630212;826.1614461321764;827.462149602757;828.0642873552877;828.2835347424494;671.6608112902953;817.9550124743166;818.3494122172887;818.4516374029384;819.2422009641087;590.0765302301927;600.9789657362015;602.5029350785619;607.7052629474701;608.1394826320751;12280.877191228063;12282.447289871978;12299.32353720545;12310.630681079581;12310.81533776994;11537;12060.216085954473;12217.450214740358;12632.557860474839;13423;11615;12252.142350035501;12268.877311226863;12290;12542.68643283916;4148.23257697324;4194.958050419487;4213.705040647156;4219.11398606293;4243.851465198703;69595.65202174007;70263.18947242104;70775.64612176958;72394.27605723929;72521;10114.797704045877;10135.290529662852;10299.485025748683;10382.37705737643;10569.365838049742;17302.394416195373;18130.184141713653;18691.15889784963;18788.906055469633;18879.244830206913;6556;6907.481938854606;6918.8942469886015;6956.860862782817;7065.505414620927;3628.564572251347;3738.7195960302543;3758.755680880734;3767.3972164454103;3804.9619503804606;2966.495695731731;3100.085474784944;3102.634840670143;3104.5498402731478;3107.2231942014496;520.4483247757314;537.6102325813832;544.7548603128608;550.3066136667827;553.8753780399378;483.30886831830117;490.87973446505833;502.18144424588417;530.3874025500553;572.68788510262;7221.277872212737;7763.029621297338;7852.37181025528;7885.723999659985;8044.959775201087;509.5897802269209;532.6271609873027;543.1337017457229;572.2274928846108;592.6473748119862;3666.1934374437583;3670.6329367063613;3686.281175170816;3709.1654377764785;3873.980630096888;105552.47223763986;106492;108506;110072.4496377529;113542;94388;94420;94489.5275523618;95460.52269738607;96717;80311;83543.58228208941;83568;83668;84136;6947.756828510978;7082.220955694973;7084.645767711697;7179.389751870941;7217.783466496014;46986.530134698216;47640.28539571979;48568.271475927184;49259.50740492549;49411.50588494069;63405.68297158669;63895;68415.3158468409;68663.65668171627;68872.6556367215;8657.52383618907;8792.692255771273;8816;8891.644334226818;9045.366824322235;10962.287451315638;11599.478023489131;11707.414629268673;11708.648740537797;12456.252624842538;11761.941190293994;12332.32172230536;12366.443510042249;12438.067144963983;12843.743125137258;10503.684889453329;10831.783364332512;10898.618548350769;11694;11715.414229288332;11949.402529873645;12073.456694448596;12079.154459187772;12295.938520307342;12799.552015679406;10050.195984321383;10167.491625418552;10548.156147508027;10671.733206669895;10814.459277036274;10052.949735251277;10722.785544289227;10751.301165424222;10827.783444330911;10885.891141088805 01:37:45 INFO - PROCESS | 28144 | __end_tp_report 01:37:45 INFO - PROCESS | 28144 | __start_cc_report 01:37:45 INFO - PROCESS | 28144 | _x_x_mozilla_cycle_collect,1130 01:37:45 INFO - PROCESS | 28144 | __end_cc_report 01:37:45 INFO - PROCESS | 28144 | __startTimestamp1470472665744__endTimestamp 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | ------- Summary: start ------- 01:37:45 INFO - PROCESS | 28144 | Number of tests: 6 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | [#0] dojo.html Cycles:165 Average:4533.46 Median:4674.42 stddev:461.79 (9.9%) stddev-sans-first:436.60 01:37:45 INFO - PROCESS | 28144 | Values: 2564.1 2581.1 2616.5 2630.6 2631.8 4389.2 4487.4 4538.7 4598.4 4605.4 4462.3 4481.7 4555.4 4611.1 4634.2 4168.0 4189.7 4225.4 4235.9 4301.8 4256.1 4290.3 4334.1 4368.3 4374.4 4275.8 4333.5 4341.8 4347.6 4379.9 4123.5 4163.9 4164.9 4193.2 4244.3 4180.2 4182.1 4214.6 4225.4 4271.9 4586.6 4591.3 4591.9 4603.2 4615.1 4768.9 4844.6 4928.3 4929.0 4934.0 4910.4 4943.6 4946.6 4947.8 4950.2 4549.4 4556.9 4597.0 4604.0 4610.4 4881.9 4930.4 5005.4 5039.4 5049.2 4853.0 4868.3 4869.0 4888.4 4893.5 4876.0 4898.9 4913.9 4921.5 4924.8 4736.5 4845.0 4852.7 4859.5 4898.8 4774.0 4843.1 4844.1 4845.6 4888.6 4154.0 4158.0 4177.2 4192.2 4207.4 3657.0 3676.2 3677.3 3708.6 3740.1 4101.4 4176.2 4220.2 4245.3 4252.1 4906.3 4912.5 4916.3 4951.0 4958.1 4170.1 4186.9 4192.5 4232.3 4233.4 4227.3 4397.6 4398.3 4404.6 4431.7 4652.5 4674.4 4676.4 4711.6 4722.5 4952.7 4952.8 4953.3 4955.5 4995.5 4472.3 4570.7 4588.7 4675.2 4705.2 4815.9 4831.3 4833.3 4862.3 4878.5 4886.8 4887.7 4890.3 4893.6 4928.5 4615.2 4687.0 4698.3 4751.8 4791.9 4738.0 4759.5 4762.2 4791.7 4814.0 4694.4 4735.2 4737.3 4737.7 4748.9 4655.9 4687.3 4750.2 4765.2 4777.7 4669.5 4690.6 4693.3 4719.2 4734.0 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | [#1] ext.html Cycles:180 Average:45642.35 Median:35465.96 stddev:82853.58 (233.6%) stddev-sans-first:83016.83 01:37:45 INFO - PROCESS | 28144 | Values: 551.1 576.3 579.1 581.4 592.4 28750.3 31368.1 31606.5 31635.5 31724.0 39124.4 39978.2 40057.6 44583.6 44693.8 7730.9 7882.3 7903.8 7916.5 7921.1 7556.2 7638.8 7639.9 7641.4 7642.0 7671.1 7674.0 7693.2 7696.3 7699.1 7635.1 7673.8 7678.0 7682.7 7694.5 7703.7 7748.8 7769.5 7771.3 7771.7 39091.6 39405.8 39456.0 39529.4 39542.8 2957.8 2977.3 3087.0 3137.4 3204.2 29479.6 30491.7 30689.5 30874.4 30900.8 3211.3 3224.3 3241.8 3376.5 3382.1 258501.7 259456.0 260293.0 261171.0 261929.0 32235.5 54167.0 54296.5 54531.5 54539.7 32210.2 34479.8 34546.3 34557.5 34567.7 13321.5 13540.9 13542.3 13546.1 13556.1 10727.2 10764.2 10801.4 10829.6 10835.7 7914.6 7930.9 7959.8 7989.7 8016.4 3134.6 3142.9 3168.7 3168.7 3196.3 795.7 846.5 919.2 928.0 984.7 28193.3 28242.3 28788.0 28813.9 28892.0 752.2 911.4 911.7 913.4 958.3 14475.6 15410.0 15478.8 15579.0 15605.7 382958.0 383075.0 384028.0 384087.0 384448.0 50502.9 50962.2 50986.7 51005.7 51064.7 1015.4 1072.5 1075.8 1138.8 1154.0 20283.0 30039.7 30427.0 30495.0 30657.4 42943.4 43446.8 43498.8 43519.1 43576.8 284140.0 285523.0 285955.0 286179.0 286297.0 25185.7 25549.5 26252.7 26311.2 27562.6 43429.8 43573.0 43576.6 43664.0 44959.3 36581.1 36633.8 36997.3 37040.3 37573.2 36364.3 37122.6 37240.0 37298.6 37768.4 31405.2 31487.4 32122.5 32206.7 32406.5 31385.7 33840.8 34034.8 34091.0 34208.0 24993.9 26997.5 27307.5 27480.6 27746.3 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | [#2] jquery.html Cycles:180 Average:25028.48 Median:6350.24 stddev:58268.17 (917.6%) stddev-sans-first:58402.16 01:37:45 INFO - PROCESS | 28144 | Values: 345.0 370.1 378.5 378.8 394.2 12872.2 16258.3 16514.8 16956.0 17929.0 16926.7 17394.0 17559.6 17723.4 17953.6 5099.6 6508.5 6785.2 6819.7 6824.5 4000.2 6562.4 6774.2 6829.7 6833.1 6836.2 6836.7 6973.9 6975.3 6991.1 6719.8 6842.4 6869.8 6880.9 6881.2 6212.0 6488.5 6673.2 6675.3 6675.4 24052.5 24130.2 24271.9 24333.5 24532.3 1892.9 2077.6 2268.7 2615.6 2660.1 14122.0 14693.6 14769.4 14815.5 15689.1 1874.0 1897.1 1923.7 1924.3 1997.5 81562.0 84859.2 85800.0 86333.6 89668.0 16198.8 16406.0 16459.7 16808.5 16942.3 29532.7 29545.7 29638.9 29720.9 29767.7 8875.6 9248.6 9409.5 9494.5 9537.1 7693.4 7744.6 7801.4 7987.1 7990.0 8128.3 8159.6 8441.0 8548.9 8590.7 3084.8 3105.7 3294.4 3333.4 3354.5 654.3 682.2 711.0 849.4 860.3 15429.2 15588.6 16167.2 16244.5 16703.5 746.6 767.1 850.7 866.8 908.8 6532.8 8825.2 8841.8 9054.6 9492.9 309703.0 311908.0 313019.0 394738.0 397090.0 84228.6 85343.6 85973.6 86407.0 86605.0 929.4 944.8 963.2 964.3 979.2 15486.1 15661.4 16005.8 16334.4 16396.8 36330.3 36891.4 36993.8 39634.2 39919.4 51638.2 52144.5 53213.5 54455.7 54978.7 6933.9 7148.9 7292.5 7322.0 7617.1 10637.8 10912.2 11004.1 11181.0 11275.0 9327.7 9637.6 9803.7 10029.7 10292.9 9253.5 9530.0 9882.3 10136.1 10439.1 9199.7 9391.7 9474.0 9931.4 10075.9 7488.3 7685.6 7695.8 7780.6 7802.8 7656.7 9768.5 10045.5 10103.8 10578.2 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | [#3] mootools.html Cycles:180 Average:5082.55 Median:5005.59 stddev:2898.94 (57.9%) stddev-sans-first:2893.47 01:37:45 INFO - PROCESS | 28144 | Values: 1346.6 1397.0 1453.7 1638.1 1683.0 7519.5 8097.1 8098.3 8126.3 8130.2 6777.5 7227.9 7488.5 7498.3 7911.3 2053.2 2104.3 2112.9 2114.4 2116.5 1985.7 2001.3 2014.0 2030.1 2033.7 1737.6 2063.0 2072.5 2154.6 2155.8 2116.4 2139.6 2140.6 2142.4 2143.8 2072.0 2137.9 2141.4 2143.0 2144.8 7845.2 7893.4 7898.6 7901.1 7906.5 4285.1 4466.5 4471.7 4472.4 4472.7 2747.2 2811.6 2844.0 2852.6 2853.6 817.6 835.6 839.8 848.9 853.4 10475.5 10670.0 10695.5 10711.0 10726.9 3985.9 4062.6 4197.0 4273.1 4287.4 9117.1 9127.0 9160.0 9190.9 9204.3 4485.8 4560.4 4579.9 4589.0 4595.6 3953.5 4119.3 4128.1 4128.9 4133.3 3497.4 3556.3 3613.4 3634.5 3639.4 1023.0 1028.6 1039.2 1047.3 1048.4 783.7 810.8 812.6 819.4 820.2 4980.3 5030.9 5080.3 5152.6 5175.6 379.5 383.5 385.7 389.3 393.8 3631.7 3687.2 3694.0 3696.5 3766.8 8995.7 9458.8 9461.7 9462.9 9477.8 9441.3 9453.8 9456.5 9472.6 9473.1 7141.4 7231.5 7234.3 7244.4 7244.7 5097.1 5106.7 5153.9 5176.7 5205.7 8550.4 8574.3 8658.2 8768.0 8773.0 8611.8 8810.3 8905.7 8948.5 8972.7 6438.7 6668.4 6835.1 6897.9 7019.3 7680.7 7738.3 7743.0 7743.1 7746.1 6839.0 6841.1 6872.8 6963.0 7064.4 6616.4 6644.7 6718.0 6735.9 6776.1 6250.0 6283.4 6300.5 6338.2 6346.2 4620.1 4621.4 4646.0 4679.7 4922.0 4506.8 4562.7 4662.8 4674.5 4756.8 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | [#4] prototype.html Cycles:180 Average:4060.67 Median:4613.76 stddev:1182.18 (25.6%) stddev-sans-first:1151.31 01:37:45 INFO - PROCESS | 28144 | Values: 299.8 302.7 310.1 313.1 314.2 4742.4 4769.9 4772.6 4773.5 4783.9 4696.2 4698.1 4708.1 4710.2 4719.6 3801.3 3805.2 3807.8 3816.0 3823.6 3460.4 3650.8 3830.9 3831.3 3833.3 3636.6 3639.6 3653.2 3657.1 3663.9 3635.6 3641.9 3642.2 3644.5 3671.0 3107.6 3128.9 3238.4 3244.4 3254.5 4550.1 4555.2 4578.7 4582.3 4583.9 4163.8 4164.2 4176.1 4176.6 4189.0 4657.3 4725.6 4893.2 4893.7 4933.8 3519.5 3523.4 3525.4 3526.4 3526.6 5144.9 5148.3 5154.6 5161.4 5168.6 3447.1 3587.6 3594.7 3644.1 3649.7 3629.9 3643.9 3662.8 3663.4 3672.4 4130.8 4137.6 4142.2 4144.6 4156.4 4860.6 4861.8 4863.8 4902.7 4903.0 1254.3 1308.6 1320.9 1322.8 1325.4 893.9 910.5 925.1 928.6 934.1 3842.9 3876.5 3887.7 3887.8 3908.2 4454.9 4461.4 4476.5 4496.5 4509.3 3911.3 3914.8 3927.2 3930.8 3946.9 2290.9 2409.8 2411.4 2425.8 2435.0 4643.7 4689.5 4829.8 4844.7 4853.8 5238.9 5245.4 5254.9 5256.3 5262.6 4680.4 4804.6 4856.5 4860.4 4869.5 5057.0 5057.1 5071.5 5075.4 5083.6 4997.4 5000.1 5000.2 5007.3 5038.6 4562.6 4768.5 4796.8 4800.7 4811.9 3604.7 3608.1 3632.3 3635.5 3651.8 5052.4 5069.9 5084.3 5106.1 5115.9 4952.5 4981.8 4982.1 4995.6 5003.4 4694.6 4915.9 4941.5 4946.6 4966.1 4847.8 4858.3 4867.7 4896.3 4896.7 4879.4 5003.0 5018.7 5021.2 5033.7 4813.6 4826.0 4856.9 4859.4 4894.3 01:37:45 INFO - PROCESS | 28144 | 01:37:45 INFO - PROCESS | 28144 | [#5] yui.html Cycles:180 Average:19006.51 Median:47313.41 stddev:28436.36 (60.1%) stddev-sans-first:28482.53 01:37:45 INFO - PROCESS | 28144 | Values: 596.7 608.5 648.4 649.0 664.9 12481.2 13357.1 13539.5 13661.6 13840.4 12350.8 12411.4 12419.7 12432.3 12437.6 639.2 770.8 788.5 788.5 790.2 762.7 785.4 785.8 792.9 794.1 819.7 826.2 827.5 828.1 828.3 671.7 818.0 818.3 818.5 819.2 590.1 601.0 602.5 607.7 608.1 12280.9 12282.4 12299.3 12310.6 12310.8 11537.0 12060.2 12217.5 12632.6 13423.0 11615.0 12252.1 12268.9 12290.0 12542.7 4148.2 4195.0 4213.7 4219.1 4243.9 69595.7 70263.2 70775.6 72394.3 72521.0 10114.8 10135.3 10299.5 10382.4 10569.4 17302.4 18130.2 18691.2 18788.9 18879.2 6556.0 6907.5 6918.9 6956.9 7065.5 3628.6 3738.7 3758.8 3767.4 3805.0 2966.5 3100.1 3102.6 3104.5 3107.2 520.4 537.6 544.8 550.3 553.9 483.3 490.9 502.2 530.4 572.7 7221.3 7763.0 7852.4 7885.7 8045.0 509.6 532.6 543.1 572.2 592.6 3666.2 3670.6 3686.3 3709.2 3874.0 105552.5 106492.0 108506.0 110072.4 113542.0 94388.0 94420.0 94489.5 95460.5 96717.0 80311.0 83543.6 83568.0 83668.0 84136.0 6947.8 7082.2 7084.6 7179.4 7217.8 46986.5 47640.3 48568.3 49259.5 49411.5 63405.7 63895.0 68415.3 68663.7 68872.7 8657.5 8792.7 8816.0 8891.6 9045.4 10962.3 11599.5 11707.4 11708.6 12456.3 11761.9 12332.3 12366.4 12438.1 12843.7 10503.7 10831.8 10898.6 11694.0 11715.4 11949.4 12073.5 12079.2 12295.9 12799.6 10050.2 10167.5 10548.2 10671.7 10814.5 10052.9 10722.8 10751.3 10827.8 10885.9 01:37:45 INFO - PROCESS | 28144 | -------- Summary: end -------- 01:37:45 INFO - PROCESS | 28144 | 01:37:46 INFO - TEST-INFO | 28144: exit 0 01:37:46 INFO - TEST-OK | dromaeo_css | took 1118985ms 01:37:46 INFO - TEST-START | kraken 01:37:46 INFO - operating with platform_type : linux_ 01:37:46 INFO - Initialising browser for kraken test... 01:37:46 INFO - TEST-INFO | started process 28328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb5f81w/profile http://localhost:32826/getInfo.html) 01:37:50 INFO - PROCESS | 28328 | __metrics Screen width/height:1600/1200 01:37:50 INFO - PROCESS | 28328 | colorDepth:24 01:37:50 INFO - PROCESS | 28328 | Browser inner width/height: 1024/697 01:37:50 INFO - PROCESS | 28328 | __metrics 01:37:51 INFO - PROCESS | 28328 | 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" 01:37:51 INFO - PROCESS | 28328 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:37:52 INFO - TEST-INFO | 28328: exit 0 01:37:52 INFO - Browser initialized. 01:37:52 INFO - Running cycle 1/1 for kraken test... 01:37:52 INFO - TEST-INFO | started process 28406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb5f81w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:04 INFO - PROCESS | 28406 | RSS: Main: 158183424 01:38:04 INFO - PROCESS | 28406 | 01:38:07 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32826/tests/kraken/driver.html?testName=audio-beat-detection) 01:38:07 INFO - PROCESS | 28406 | RSS: Main: 213958656 01:38:07 INFO - PROCESS | 28406 | 01:38:10 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32826/tests/kraken/driver.html?testName=audio-dft) 01:38:11 INFO - PROCESS | 28406 | RSS: Main: 192688128 01:38:11 INFO - PROCESS | 28406 | 01:38:14 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32826/tests/kraken/driver.html?testName=audio-fft) 01:38:15 INFO - PROCESS | 28406 | RSS: Main: 271421440 01:38:15 INFO - PROCESS | 28406 | 01:38:17 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32826/tests/kraken/driver.html?testName=audio-oscillator) 01:38:17 INFO - PROCESS | 28406 | RSS: Main: 181059584 01:38:17 INFO - PROCESS | 28406 | 01:38:20 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:38:20 INFO - PROCESS | 28406 | RSS: Main: 185610240 01:38:20 INFO - PROCESS | 28406 | 01:38:23 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32826/tests/kraken/driver.html?testName=imaging-darkroom) 01:38:24 INFO - PROCESS | 28406 | RSS: Main: 221483008 01:38:24 INFO - PROCESS | 28406 | 01:38:27 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32826/tests/kraken/driver.html?testName=imaging-desaturate) 01:38:28 INFO - PROCESS | 28406 | RSS: Main: 221110272 01:38:28 INFO - PROCESS | 28406 | 01:38:31 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32826/tests/kraken/driver.html?testName=json-parse-financial) 01:38:32 INFO - PROCESS | 28406 | RSS: Main: 220577792 01:38:32 INFO - PROCESS | 28406 | 01:38:33 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:38:34 INFO - PROCESS | 28406 | RSS: Main: 185614336 01:38:34 INFO - PROCESS | 28406 | 01:38:36 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:38:36 INFO - PROCESS | 28406 | RSS: Main: 190398464 01:38:36 INFO - PROCESS | 28406 | 01:38:39 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:38:39 INFO - PROCESS | 28406 | RSS: Main: 195559424 01:38:39 INFO - PROCESS | 28406 | 01:38:42 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:38:43 INFO - PROCESS | 28406 | RSS: Main: 190619648 01:38:43 INFO - PROCESS | 28406 | 01:38:45 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:38:46 INFO - PROCESS | 28406 | RSS: Main: 193159168 01:38:46 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | Cycle 1(1): loaded http://localhost:32826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32826/tests/kraken/driver.html?testName=ai-astar) 01:38:48 INFO - PROCESS | 28406 | RSS: Main: 244207616 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | __start_tp_report 01:38:48 INFO - PROCESS | 28406 | _x_x_mozilla_page_load 01:38:48 INFO - PROCESS | 28406 | _x_x_mozilla_page_load_details 01:38:48 INFO - PROCESS | 28406 | |i|pagename|runs| 01:38:48 INFO - PROCESS | 28406 | |0;ai-astar;104;115;114;114;114;114;113;113;114;113 01:38:48 INFO - PROCESS | 28406 | |1;audio-beat-detection;155;122;127;184;124;124;154;122;158;120 01:38:48 INFO - PROCESS | 28406 | |2;audio-dft;160;162;163;160;162;169;162;160;162;161 01:38:48 INFO - PROCESS | 28406 | |3;audio-fft;75;75;75;112;75;76;75;75;103;75 01:38:48 INFO - PROCESS | 28406 | |4;audio-oscillator;86;86;136;85;86;85;119;85;86;124 01:38:48 INFO - PROCESS | 28406 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 01:38:48 INFO - PROCESS | 28406 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;147;147 01:38:48 INFO - PROCESS | 28406 | |7;imaging-desaturate;95;95;95;94;95;95;94;95;94;94 01:38:48 INFO - PROCESS | 28406 | |8;json-parse-financial;63;62;63;62;62;63;64;70;63;62 01:38:48 INFO - PROCESS | 28406 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;66;66;65 01:38:48 INFO - PROCESS | 28406 | |10;stanford-crypto-aes;83;79;79;78;90;81;79;79;79;81 01:38:48 INFO - PROCESS | 28406 | |11;stanford-crypto-ccm;133;130;131;129;129;129;130;129;154;133 01:38:48 INFO - PROCESS | 28406 | |12;stanford-crypto-pbkdf2;169;164;168;165;165;168;170;168;165;165 01:38:48 INFO - PROCESS | 28406 | |13;stanford-crypto-sha256-iterative;74;69;67;70;66;66;67;66;66;67 01:38:48 INFO - PROCESS | 28406 | __end_tp_report 01:38:48 INFO - PROCESS | 28406 | __start_cc_report 01:38:48 INFO - PROCESS | 28406 | _x_x_mozilla_cycle_collect,1919 01:38:48 INFO - PROCESS | 28406 | __end_cc_report 01:38:48 INFO - PROCESS | 28406 | __startTimestamp1470472728613__endTimestamp 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | ------- Summary: start ------- 01:38:48 INFO - PROCESS | 28406 | Number of tests: 14 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:0.67 01:38:48 INFO - PROCESS | 28406 | Values: 104.0 115.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:140.50 stddev:22.11 (15.7%) stddev-sans-first:22.68 01:38:48 INFO - PROCESS | 28406 | Values: 155.0 122.0 127.0 184.0 124.0 124.0 154.0 122.0 158.0 120.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.64 (1.6%) stddev-sans-first:2.69 01:38:48 INFO - PROCESS | 28406 | Values: 160.0 162.0 163.0 160.0 162.0 169.0 162.0 160.0 162.0 161.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:13.82 (18.4%) stddev-sans-first:14.45 01:38:48 INFO - PROCESS | 28406 | Values: 75.0 75.0 75.0 112.0 75.0 76.0 75.0 75.0 103.0 75.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:85.50 stddev:20.12 (23.5%) stddev-sans-first:20.88 01:38:48 INFO - PROCESS | 28406 | Values: 86.0 86.0 136.0 85.0 86.0 85.0 119.0 85.0 86.0 124.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:38:48 INFO - PROCESS | 28406 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 01:38:48 INFO - PROCESS | 28406 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:38:48 INFO - PROCESS | 28406 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:2.41 (3.8%) stddev-sans-first:2.55 01:38:48 INFO - PROCESS | 28406 | Values: 63.0 62.0 63.0 62.0 62.0 63.0 64.0 70.0 63.0 62.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:38:48 INFO - PROCESS | 28406 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 66.0 65.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:3.55 (4.4%) stddev-sans-first:3.68 01:38:48 INFO - PROCESS | 28406 | Values: 83.0 79.0 79.0 78.0 90.0 81.0 79.0 79.0 79.0 81.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:130.50 stddev:7.65 (5.9%) stddev-sans-first:8.11 01:38:48 INFO - PROCESS | 28406 | Values: 133.0 130.0 131.0 129.0 129.0 129.0 130.0 129.0 154.0 133.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:168.00 stddev:2.11 (1.3%) stddev-sans-first:2.07 01:38:48 INFO - PROCESS | 28406 | Values: 169.0 164.0 168.0 165.0 165.0 168.0 170.0 168.0 165.0 165.0 01:38:48 INFO - PROCESS | 28406 | 01:38:48 INFO - PROCESS | 28406 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.57 (3.8%) stddev-sans-first:1.45 01:38:48 INFO - PROCESS | 28406 | Values: 74.0 69.0 67.0 70.0 66.0 66.0 67.0 66.0 66.0 67.0 01:38:48 INFO - PROCESS | 28406 | -------- Summary: end -------- 01:38:48 INFO - PROCESS | 28406 | 01:38:49 INFO - TEST-INFO | 28406: exit 0 01:38:49 INFO - TEST-OK | kraken | took 63133ms 01:38:49 INFO - SUITE-END | took 1182s 01:38:49 INFO - Completed test suite (00:19:42) 01:38:49 INFO - javascript benchmark 01:38:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.051301018623, 2581.070814506776, 2616.4897844920242, 2630.644862943502, 2631.815772895896, 4389.188000219961, 4487.439070116236, 4538.7276763394175, 4598.402207712997, 4605.378273933014, 4462.286034234523, 4481.686281960264, 4555.385023021891, 4611.146937816507, 4634.189016922033, 4167.9583204167875, 4189.706720529564, 4225.408442818016, 4235.851745188919, 4301.849435269766, 4256.106217694288, 4290.292101803198, 4334.133173365324, 4368.279233926399, 4374.4313239278845, 4275.8075886585175, 4333.544977777336, 4341.804618792162, 4347.60871521563, 4379.934300985487, 4123.484564429446, 4163.875083747493, 4164.895877603054, 4193.224253513079, 4244.342126970325, 4180.226658068267, 4182.100848317596, 4214.641755450791, 4225.3873188387515, 4271.9359209611885, 4586.610138138262, 4591.288350305708, 4591.908161836778, 4603.171429142753, 4615.100055489181, 4768.856934291976, 4844.63665225106, 4928.33467481889, 4929.0, 4933.950660493385, 4910.386201724785, 4943.604511639061, 4946.579540739005, 4947.752612369403, 4950.232713929347, 4549.385832912514, 4556.908861822745, 4597.034622729231, 4604.010137820384, 4610.377599024156, 4881.926771098437, 4930.359053323117, 5005.424376196711, 5039.420466646309, 5049.2173713074535, 4852.975735121372, 4868.318435419044, 4869.001854619865, 4888.437829649636, 4893.486183950705, 4876.0, 4898.853034408973, 4913.852584422473, 4921.532454416824, 4924.8276310328965, 4736.478987311393, 4844.95155048452, 4852.660313778002, 4859.538343857328, 4898.779554920037, 4774.0, 4843.07981483517, 4844.0554091951735, 4845.563899249085, 4888.608911287089, 4153.979230103891, 4158.022864626811, 4177.185448837447, 4192.182524407772, 4207.431996680409, 3656.9634303657153, 3676.2279921216846, 3677.3196958562216, 3708.610595887447, 3740.139767853409, 4101.405296232029, 4176.206520761046, 4220.240356735756, 4245.299525578245, 4252.128313695685, 4906.31311616374, 4912.533309335608, 4916.262560615936, 4951.034548263126, 4958.132326842788, 4170.082581831992, 4186.937195942063, 4192.4759405074365, 4232.32282834745, 4233.364995250737, 4227.260229459832, 4397.560243975641, 4398.340248962617, 4404.559544045634, 4431.711938723973, 4652.464966528893, 4674.415698037746, 4676.392069031004, 4711.57595816385, 4722.456917454537, 4952.678075925053, 4952.752362381939, 4953.331300274417, 4955.479674634112, 4995.450500444876, 4472.284434490466, 4570.657200709894, 4588.655850811136, 4675.181843177498, 4705.247160454311, 4815.927761083657, 4831.275308703582, 4833.250846118857, 4862.270659401118, 4878.463369029333, 4886.828960986349, 4887.706737595756, 4890.2909078184175, 4893.632977526771, 4928.457869634409, 4615.169269531382, 4687.039156972744, 4698.271767875985, 4751.83368582098, 4791.904161916673, 4738.0, 4759.524047595212, 4762.214234651244, 4791.736454495036, 4814.0, 4694.366260554782, 4735.21868891629, 4737.336772851734, 4737.739424331557, 4748.857534273978, 4655.883602909955, 4687.250039993584, 4750.216214324598, 4765.237561990065, 4777.737224452689, 4669.509701481432, 4690.577847993697, 4693.319468676955, 4719.197736384892, 4734.0], "value": 4504.948413604248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1377056924651, 576.2940398012436, 579.1284117403308, 581.380829416671, 592.4164697772693, 28750.281242968937, 31368.05895823123, 31606.525902111487, 31635.525467117954, 31724.0, 39124.41313380295, 39978.20043599126, 40057.59942400575, 44583.55416445834, 44693.77653111738, 7730.884036739468, 7882.290593846553, 7903.8419231615335, 7916.485428447132, 7921.08907475639, 7556.168821429638, 7638.770836874903, 7639.9236007639765, 7641.4268929830205, 7641.961790191069, 7671.079470463552, 7674.040744906887, 7693.192214817447, 7696.345810606077, 7699.114601820778, 7635.121960974503, 7673.769786906401, 7677.961610191969, 7682.692692292301, 7694.499857509244, 7703.653335599912, 7748.845023099507, 7769.494982826155, 7771.300582947505, 7771.689132434696, 39091.60908390908, 39405.802970984965, 39456.0, 39529.40705889414, 39542.802285988386, 2957.8373189474787, 2977.330100727341, 3086.9536956945662, 3137.356841847439, 3204.1829333519804, 29479.557806632918, 30491.695083049108, 30689.539656905163, 30874.382512349628, 30900.845495772377, 3211.2935154266024, 3224.3067740435918, 3241.8379081045855, 3376.5441665375106, 3382.0699307690584, 258501.70749146322, 259456.0, 260293.0, 261171.0, 261929.0, 32235.516467253008, 54167.0, 54296.45703542993, 54531.454685453435, 54539.72730136324, 32210.19474513156, 34479.827600861834, 34546.309073818884, 34557.481637775454, 34567.65432345695, 13321.467141314239, 13540.932295338658, 13542.322883855768, 13546.119502232323, 13556.11885227457, 10727.195460340507, 10764.246502744889, 10801.405922674172, 10829.566817327219, 10835.729106772395, 7914.643841027168, 7930.920690793134, 7959.761207163794, 7989.680412783539, 8016.398770092266, 3134.6081739782526, 3142.8742850285735, 3168.651448340681, 3168.66728993457, 3196.280836811699, 795.677750511044, 846.4921047371528, 919.1865199298535, 927.9953600231955, 984.6504490905626, 28193.295167620563, 28242.2939426516, 28788.0, 28813.85593072063, 28892.0, 752.236479972828, 911.4075850696968, 911.7355966769695, 913.4062859141478, 958.3483231402713, 14475.638109047359, 15410.0, 15478.845211547965, 15579.0, 15605.68788624221, 382958.0, 383075.0, 384028.0, 384087.0, 384448.0, 50502.939647242565, 50962.23556646653, 50986.74506627443, 51005.74497127565, 51064.74467627712, 1015.4262841494532, 1072.5334479501441, 1075.8386242063596, 1138.7893239750672, 1153.9826902596467, 20283.0, 30039.69960300369, 30427.0, 30495.0, 30657.386852263277, 42943.355849662905, 43446.78276608597, 43498.782506087264, 43519.12961740811, 43576.782116090486, 284140.0, 285523.0, 285955.0, 286179.0, 286297.0, 25185.74814251834, 25549.489010220062, 26252.73747262503, 26311.21066368012, 27562.5865612012, 43429.78285108554, 43573.0, 43576.56423435852, 43664.0, 44959.32561011653, 36581.08547286339, 36633.816830915675, 36997.31903485272, 37040.25919481649, 37573.24853502969, 36364.27271454609, 37122.62877371192, 37240.0, 37298.627013729514, 37768.43347349737, 31405.214869628442, 31487.37025259528, 32122.518162228054, 32206.67793322037, 32406.51390229101, 31385.686143139188, 33840.83079584586, 34034.82982585071, 34091.0, 34208.0, 24993.87503062473, 26997.46005079848, 27307.453850923266, 27480.58779118355, 27746.306342341602], "value": 16344.38916129921, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9862005519776, 370.09511743786436, 378.48148037189037, 378.79734342126966, 394.1506054452654, 12872.227666340026, 16258.34966601336, 16514.834851651496, 16956.0, 17929.01390423526, 16926.74609880853, 17394.0, 17559.561010974732, 17723.379681711143, 17953.64092718145, 5099.643024988243, 6508.47932165428, 6785.2196997345445, 6819.659017049153, 6824.454043676494, 4000.2399544086675, 6562.3765742254645, 6774.220964589086, 6829.658517074151, 6833.145856767904, 6836.248012718622, 6836.726530938757, 6973.895391569131, 6975.2675969023285, 6991.091158149434, 6719.798406047802, 6842.418394436479, 6869.7595584154815, 6880.862382752317, 6881.174259088892, 6212.0, 6488.480921526267, 6673.165854268216, 6675.332466753334, 6675.365840245169, 24052.51894962091, 24130.155444559357, 24271.878640606683, 24333.513329733305, 24532.264032079067, 1892.9337473188373, 2077.574097310048, 2268.7164104486938, 2615.6207349934343, 2660.148752399233, 14122.0, 14693.632659183499, 14769.409223631043, 14815.481458148914, 15689.058656480647, 1874.0, 1897.1368027547433, 1923.6729755941524, 1924.2976313645559, 1997.460685614876, 81562.0, 84859.15140848575, 85800.0, 86333.56833215857, 89668.0, 16198.838011619733, 16406.0, 16459.670806583803, 16808.495745127664, 16942.322307107825, 29532.704672952994, 29545.704542954725, 29638.851805740833, 29720.851395742884, 29767.702322976926, 8875.600597973107, 9248.583813728399, 9409.482478463613, 9494.477803720862, 9537.093976072261, 7693.422993275415, 7744.574048427278, 7801.375889928792, 7987.1214166442805, 7989.960050199712, 8128.349732021424, 8159.632816523152, 8440.957795210985, 8548.914510854936, 8590.661715833588, 3084.7994880333154, 3105.736012438968, 3294.374068926896, 3333.448940460699, 3354.5471361365903, 654.3489228217953, 682.2018238660779, 710.9608971506617, 849.3757088539918, 860.324645153564, 15429.228538573027, 15588.610284742745, 16167.191640418167, 16244.51266462008, 16703.498895033168, 746.6154930210946, 767.1369709077288, 850.7277671145174, 866.8049688819965, 908.7591788176138, 6532.8040158794365, 8825.205731484197, 8841.778955526035, 9054.592543335566, 9492.857607135898, 309703.0, 311908.0, 313019.0, 394738.0, 397090.0, 84228.57885710655, 85343.57328213319, 85973.57013215018, 86407.0, 86605.0, 929.4051806843626, 944.8488241881404, 963.2294164668237, 964.3249725192253, 979.24108815667, 15486.148261845707, 15661.373545058526, 16005.759913601072, 16334.428295009619, 16396.83603163953, 36330.27339453143, 36891.44662830006, 36993.81503092467, 39634.207315852946, 39919.401208981304, 51638.22542661788, 52144.478555213966, 53213.4678653224, 54455.72772136114, 54978.725106374215, 6933.861322773415, 7148.85702285941, 7292.525985811118, 7321.986453725268, 7617.085949685851, 10637.787244254916, 10912.181586380895, 11004.119670426508, 11181.0, 11275.003847700551, 9327.720168394959, 9637.566309515949, 9803.705888823346, 10029.749256268651, 10292.948535257576, 9253.53732313395, 9530.0, 9882.25883058759, 10136.138428233682, 10439.060484556427, 9199.724008279762, 9391.671291504765, 9473.957864634747, 9931.404115753077, 10075.949620251851, 7488.326050655467, 7685.615719214129, 7695.807604809925, 7780.610969451618, 7802.843943121219, 7656.6554505048525, 9768.511574421393, 10045.547950342398, 10103.848442273518, 10578.15374770032], "value": 9302.628910945064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.6027521881042, 1396.97904531432, 1453.6583902782845, 1638.1154176744558, 1683.0322564525402, 7519.473636845416, 8097.14979927108, 8098.311643510308, 8126.268635822775, 8130.186981301867, 6777.457803375731, 7227.89158162628, 7488.475806693534, 7498.250174982512, 7911.287984081431, 2053.178728508601, 2104.284543255293, 2112.8943552822375, 2114.3656902929138, 2116.5449428372895, 1985.6525108106096, 2001.3095482058739, 2013.9798602014012, 2030.0763152765455, 2033.6949457581334, 1737.5742942978989, 2062.9994452690507, 2072.492239401349, 2154.5906277807244, 2155.8059774620283, 2116.4179850541072, 2139.6255655260425, 2140.5825863956534, 2142.389419015581, 2143.8070573648447, 2071.968920466194, 2137.850350475467, 2141.4325203821, 2143.046344376753, 2144.8069673729437, 7845.215478452166, 7893.447458677895, 7898.644560994769, 7901.09137449195, 7906.486078404942, 4285.142971405731, 4466.486354069291, 4471.709338892962, 4472.396226509412, 4472.731636101845, 2747.175847245838, 2811.5501519756945, 2844.0, 2852.6148969889214, 2853.5576985567272, 817.6443247187433, 835.5613303015965, 839.8236370362231, 848.9066202717696, 853.4239388412797, 10475.528601212887, 10670.0, 10695.465226738632, 10711.0, 10726.892731072667, 3985.880423587297, 4062.614051665087, 4197.0, 4273.1240095780295, 4287.442632457823, 9117.133872282122, 9127.0, 9160.0, 9190.90809091914, 9204.309676774268, 4485.798139083749, 4560.361549383089, 4579.931301030487, 4589.036302376471, 4595.632349412039, 3953.5453422856162, 4119.299719047769, 4128.091819799639, 4128.896777580524, 4133.297339452301, 3497.405441075023, 3556.270964452281, 3613.3676606594267, 3634.454831775202, 3639.417693169133, 1022.9744256393501, 1028.6296933104077, 1039.2465462539599, 1047.3349423116224, 1048.3500229857536, 783.7217787685404, 810.7973006748313, 812.6180695073306, 819.4141189049858, 820.2003047029218, 4980.302757613937, 5030.874228144326, 5080.288759573588, 5152.639315247971, 5175.611829112831, 379.45358683496227, 383.54549858417863, 385.7107169622783, 389.2895465774972, 393.8247479871487, 3631.727620428426, 3687.188818459988, 3693.978546929204, 3696.482492451059, 3766.7739935603404, 8995.730128096167, 9458.763530911645, 9461.716148515556, 9462.858057129148, 9477.763055923657, 9441.291903107294, 9453.76365590852, 9456.479893605918, 9472.621095156117, 9473.100055494717, 7141.357277845019, 7231.517538904512, 7234.348908598251, 7244.38422734063, 7244.746433874789, 5097.133487307241, 5106.719130447861, 5153.922691159711, 5176.7152806594495, 5205.713685747321, 8550.444221125606, 8574.27118694893, 8658.220760131619, 8768.0, 8773.0, 8611.827763444571, 8810.339224558313, 8905.688300909436, 8948.5078320693, 8972.730818075468, 6438.67806609677, 6668.433183179484, 6835.14560679915, 6897.89653155193, 7019.262977387505, 7680.731174408869, 7738.264864837832, 7742.961285193764, 7743.070831500256, 7746.147923728273, 6839.042534045138, 6841.076454678555, 6872.828179295558, 6962.965185174042, 7064.434845212473, 6616.371444712745, 6644.734210631521, 6717.966410168114, 6735.898961515679, 6776.08522849409, 6249.96875015622, 6283.434490895658, 6300.464460520907, 6338.239411270677, 6346.174997250328, 4620.145273124483, 4621.399218101626, 4645.976770116128, 4679.719216847, 4922.040202160544, 4506.819727210875, 4562.65780066503, 4662.813487460599, 4674.5091765365505, 4756.762161891961], "value": 3982.3360618116026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.7721731484072, 302.68067189115476, 310.14400255295385, 313.1185712220102, 314.1909582824228, 4742.383490146281, 4769.879078416569, 4772.570468657825, 4773.522647735224, 4783.880402989927, 4696.225122854725, 4698.13084579353, 4708.128996135709, 4710.175719249126, 4719.575238228567, 3801.33476641588, 3805.2389522095555, 3807.8476860925666, 3816.0, 3823.617638236168, 3460.4117300058924, 3650.7627004244773, 3830.9042273943237, 3831.3103641344546, 3833.3291673957087, 3636.6181550937035, 3639.5632524097146, 3653.1597732521536, 3657.122290650238, 3663.8534458621625, 3635.600083990759, 3641.9453708194396, 3642.1805093853936, 3644.489771432002, 3671.0088276165284, 3107.6115485564305, 3128.89048883288, 3238.352329534079, 3244.3997860395903, 3254.5118232265113, 4550.089982003613, 4555.180067587833, 4578.748168850712, 4582.312653102028, 4583.862484125481, 4163.75017498951, 4164.229617520768, 4176.081262122329, 4176.62410383064, 4188.979055104735, 4657.301404789275, 4725.621950243973, 4893.1926232171645, 4893.657443978923, 4933.827316043958, 3519.472079188117, 3523.3834079036064, 3525.4006818840858, 3526.435770276769, 3526.642242736565, 5144.948550514522, 5148.304978827848, 5154.639175257734, 5161.354830646169, 5168.61235407346, 3447.1382154461385, 3587.587427445825, 3594.658507441789, 3644.0889777555612, 3649.7080233581783, 3629.927401452009, 3643.9089022774115, 3662.8168591570316, 3663.377225871608, 3672.3756961316108, 4130.772807495557, 4137.551856850078, 4142.1922725068325, 4144.626983571493, 4156.355764856452, 4860.6111511079025, 4861.781219845116, 4863.805447782049, 4902.730349830722, 4902.950970490249, 1254.2599866079056, 1308.6335825968745, 1320.8745169209103, 1322.7751282282036, 1325.4035683942266, 893.8927328720465, 910.4810258152921, 925.1303774451993, 928.6471140966524, 934.0985948559537, 3842.925659472411, 3876.457295978565, 3887.7278590498395, 3887.844486220576, 3908.2285594401537, 4454.933176002362, 4461.353103799931, 4476.485204201558, 4496.527864574173, 4509.339489701027, 3911.298585115484, 3914.8434062637175, 3927.2341893330527, 3930.76415415076, 3946.8751405849193, 2290.9083636654345, 2409.8433601815827, 2411.385096800305, 2425.830191886551, 2434.9513009740062, 4643.651726120487, 4689.484156742756, 4829.806807727722, 4844.729807380075, 4853.830115945995, 5238.869028274324, 5245.396779370421, 5254.894902102013, 5256.26412302278, 5262.631615786935, 4680.3915490985955, 4804.615630749462, 4856.543037088859, 4860.36815214027, 4869.537393947569, 5056.974715126548, 5057.14028615129, 5071.45320677197, 5075.390953085654, 5083.644144909821, 4997.400311962588, 5000.14997450427, 5000.199968005102, 5007.29897814299, 5038.647294689483, 4562.5665561771575, 4768.499307572793, 4796.832110876103, 4800.687955282895, 4811.879703007313, 3604.7116230702004, 3608.1340478285547, 3632.255387645579, 3635.5092062571216, 3651.7808931464197, 5052.393712754493, 5069.8732531687, 5084.2627818966785, 5106.106431374569, 5115.948840511547, 4952.455229924633, 4981.775820088033, 4982.128127577732, 4995.575376093073, 5003.449620541664, 4694.6244300456565, 4915.926261106158, 4941.481144479922, 4946.62900282473, 4966.056449274626, 4847.830325938575, 4858.271259311132, 4867.70793752376, 4896.2655601660035, 4896.6572339935865, 4879.365682461257, 5003.0, 5018.67005243618, 5021.221710634857, 5033.723145226902, 4813.614910807057, 4825.9865428260455, 4856.902861942671, 4859.392575928009, 4894.33926419943], "value": 3698.0367309425837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7255062671171, 608.479749813909, 648.3840351665916, 649.0426620734415, 664.9002649602562, 12481.188722733028, 13357.131786433874, 13539.458421663121, 13661.590152295435, 13840.377183026763, 12350.752984940296, 12411.379431028457, 12419.689507762288, 12432.316222607753, 12437.62687119388, 639.1882309466974, 770.7533589251427, 788.4835432791502, 788.4993029426327, 790.1742678900534, 762.7139822566537, 785.4344871692373, 785.8153333966513, 792.8969233999601, 794.0788685125256, 819.6885183630212, 826.1614461321764, 827.462149602757, 828.0642873552877, 828.2835347424494, 671.6608112902953, 817.9550124743166, 818.3494122172887, 818.4516374029384, 819.2422009641087, 590.0765302301927, 600.9789657362015, 602.5029350785619, 607.7052629474701, 608.1394826320751, 12280.877191228063, 12282.447289871978, 12299.32353720545, 12310.630681079581, 12310.81533776994, 11537.0, 12060.216085954473, 12217.450214740358, 12632.557860474839, 13423.0, 11615.0, 12252.142350035501, 12268.877311226863, 12290.0, 12542.68643283916, 4148.23257697324, 4194.958050419487, 4213.705040647156, 4219.11398606293, 4243.851465198703, 69595.65202174007, 70263.18947242104, 70775.64612176958, 72394.27605723929, 72521.0, 10114.797704045877, 10135.290529662852, 10299.485025748683, 10382.37705737643, 10569.365838049742, 17302.394416195373, 18130.184141713653, 18691.15889784963, 18788.906055469633, 18879.244830206913, 6556.0, 6907.481938854606, 6918.8942469886015, 6956.860862782817, 7065.505414620927, 3628.564572251347, 3738.7195960302543, 3758.755680880734, 3767.3972164454103, 3804.9619503804606, 2966.495695731731, 3100.085474784944, 3102.634840670143, 3104.5498402731478, 3107.2231942014496, 520.4483247757314, 537.6102325813832, 544.7548603128608, 550.3066136667827, 553.8753780399378, 483.30886831830117, 490.87973446505833, 502.18144424588417, 530.3874025500553, 572.68788510262, 7221.277872212737, 7763.029621297338, 7852.37181025528, 7885.723999659985, 8044.959775201087, 509.5897802269209, 532.6271609873027, 543.1337017457229, 572.2274928846108, 592.6473748119862, 3666.1934374437583, 3670.6329367063613, 3686.281175170816, 3709.1654377764785, 3873.980630096888, 105552.47223763986, 106492.0, 108506.0, 110072.4496377529, 113542.0, 94388.0, 94420.0, 94489.5275523618, 95460.52269738607, 96717.0, 80311.0, 83543.58228208941, 83568.0, 83668.0, 84136.0, 6947.756828510978, 7082.220955694973, 7084.645767711697, 7179.389751870941, 7217.783466496014, 46986.530134698216, 47640.28539571979, 48568.271475927184, 49259.50740492549, 49411.50588494069, 63405.68297158669, 63895.0, 68415.3158468409, 68663.65668171627, 68872.6556367215, 8657.52383618907, 8792.692255771273, 8816.0, 8891.644334226818, 9045.366824322235, 10962.287451315638, 11599.478023489131, 11707.414629268673, 11708.648740537797, 12456.252624842538, 11761.941190293994, 12332.32172230536, 12366.443510042249, 12438.067144963983, 12843.743125137258, 10503.684889453329, 10831.783364332512, 10898.618548350769, 11694.0, 11715.414229288332, 11949.402529873645, 12073.456694448596, 12079.154459187772, 12295.938520307342, 12799.552015679406, 10050.195984321383, 10167.491625418552, 10548.156147508027, 10671.733206669895, 10814.459277036274, 10052.949735251277, 10722.785544289227, 10751.301165424222, 10827.783444330911, 10885.891141088805], "value": 6615.088183498748, "unit": "score"}], "name": "dromaeo_css", "value": 6368.839009395502, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 127.0, 184.0, 124.0, 124.0, 154.0, 122.0, 158.0, 120.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 160.0, 162.0, 169.0, 162.0, 160.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 112.0, 75.0, 76.0, 75.0, 75.0, 103.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 136.0, 85.0, 86.0, 85.0, 119.0, 85.0, 86.0, 124.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 64.0, 70.0, 63.0, 62.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 79.0, 78.0, 90.0, 81.0, 79.0, 79.0, 79.0, 81.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 131.0, 129.0, 129.0, 129.0, 130.0, 129.0, 154.0, 133.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 168.0, 165.0, 165.0, 168.0, 170.0, 168.0, 165.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 67.0, 70.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1528.0, "alertThreshold": 2.0}]} 01:38:49 INFO - Return code: 0 01:38:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:38:49 INFO - # TBPL SUCCESS # 01:38:49 INFO - Running post-action listener: _resource_record_post_action 01:38:49 INFO - [mozharness: 2016-08-06 08:38:49.910164Z] Finished run-tests step (success) 01:38:49 INFO - Running post-run listener: _resource_record_post_run 01:38:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534179840; Read time: 16; Write time: 458544 01:38:49 INFO - TinderboxPrint: CPU usage
13.0% 01:38:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:38:49 INFO - TinderboxPrint: I/O write bytes / time
534,179,840 / 458,544 01:38:49 INFO - TinderboxPrint: CPU idle
8,318.3 (87.0%) 01:38:49 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 01:38:49 INFO - TinderboxPrint: Swap in / out
0 / 0 01:38:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252071936; Read time: 0; Write time: 238508 01:38:49 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 282107904; Read time: 0; Write time: 220036 01:38:50 INFO - Running post-run listener: _upload_blobber_files 01:38:50 INFO - Blob upload gear active. 01:38:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:38:50 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 01:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:38:50 INFO - (blobuploader) - INFO - Open directory for files ... 01:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:38:52 INFO - (blobuploader) - INFO - Done attempting. 01:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:38:52 INFO - (blobuploader) - INFO - Done attempting. 01:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:38:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:38:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:38:56 INFO - (blobuploader) - INFO - Done attempting. 01:38:56 INFO - (blobuploader) - INFO - Iteration through files over. 01:38:56 INFO - Return code: 0 01:38:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:38:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:38:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f00a3c0c0a38166aa61bfd913b3d4a6a0c8ed6a954f1f3640c2fbc0250ecbebbecff39849c0774b97c78b1a06712990c4e755f4d431f0cce6db4011654ea0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41e8f4f9665a249f46efd50f731e91a306383370dd90bf123de48f0bdbe64164357ca69e459bde4174018bc92ca769a6a02d16c5d847d40a6058b67dd74cee3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a49e2447f1af516d1c1985ef1e145d4ccbbfd578294e9d74a83ec2f7f647bca992ad327c59c7ad8e92c586ae26476ff5f0b3ce7d0a267cdbf238ba922e243dc6"} 01:38:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:38:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:38:56 INFO - Contents: 01:38:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f00a3c0c0a38166aa61bfd913b3d4a6a0c8ed6a954f1f3640c2fbc0250ecbebbecff39849c0774b97c78b1a06712990c4e755f4d431f0cce6db4011654ea0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41e8f4f9665a249f46efd50f731e91a306383370dd90bf123de48f0bdbe64164357ca69e459bde4174018bc92ca769a6a02d16c5d847d40a6058b67dd74cee3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a49e2447f1af516d1c1985ef1e145d4ccbbfd578294e9d74a83ec2f7f647bca992ad327c59c7ad8e92c586ae26476ff5f0b3ce7d0a267cdbf238ba922e243dc6"} 01:38:56 INFO - Running post-run listener: copy_logs_to_upload_dir 01:38:56 INFO - Copying logs to upload dir... 01:38:56 INFO - mkdir: /builds/slave/test/build/upload/logs 01:38:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.747346 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-06 01:38:56.462848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 01:38:56.466370) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f00a3c0c0a38166aa61bfd913b3d4a6a0c8ed6a954f1f3640c2fbc0250ecbebbecff39849c0774b97c78b1a06712990c4e755f4d431f0cce6db4011654ea0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41e8f4f9665a249f46efd50f731e91a306383370dd90bf123de48f0bdbe64164357ca69e459bde4174018bc92ca769a6a02d16c5d847d40a6058b67dd74cee3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a49e2447f1af516d1c1985ef1e145d4ccbbfd578294e9d74a83ec2f7f647bca992ad327c59c7ad8e92c586ae26476ff5f0b3ce7d0a267cdbf238ba922e243dc6"} build_url:https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/M9fY9cEmRmSXkM7o1rZ9Bw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f00a3c0c0a38166aa61bfd913b3d4a6a0c8ed6a954f1f3640c2fbc0250ecbebbecff39849c0774b97c78b1a06712990c4e755f4d431f0cce6db4011654ea0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41e8f4f9665a249f46efd50f731e91a306383370dd90bf123de48f0bdbe64164357ca69e459bde4174018bc92ca769a6a02d16c5d847d40a6058b67dd74cee3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a49e2447f1af516d1c1985ef1e145d4ccbbfd578294e9d74a83ec2f7f647bca992ad327c59c7ad8e92c586ae26476ff5f0b3ce7d0a267cdbf238ba922e243dc6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 01:38:56.491589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:38:56.491926) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470470856.687633-2102695553 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 01:38:56.577268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 01:38:56.577623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 01:38:56.578315) ========= ========= Total master_lag: 0.17 =========