builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1471489756.97 results: success (0) buildid: 20160817173001 builduid: 921c711a151f4d7e983975cc6adec061 revision: 11c94ec980d60a48be403d003798d64269e785ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:16.968771) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:16.969201) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:16.969488) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.282190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.282469) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 20:09:18-- 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% 222M=0s 2016-08-17 20:09:18 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.451369) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.452832) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.509528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.509892) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11c94ec980d60a48be403d003798d64269e785ef --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 11c94ec980d60a48be403d003798d64269e785ef --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=a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 20:09:18,618 truncating revision to first 12 chars 2016-08-17 20:09:18,618 Setting DEBUG logging. 2016-08-17 20:09:18,618 attempt 1/10 2016-08-17 20:09:18,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11c94ec980d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 20:09:18,929 unpacking tar archive at: fx-team-11c94ec980d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640665 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.167821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.168132) ========= script_repo_revision: 11c94ec980d60a48be403d003798d64269e785ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.168563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.168889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.178902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-17 20:09:18.179167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:19 INFO - MultiFileLogger online at 20160817 20:09:19 in /builds/slave/test 20:09:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:09:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:19 INFO - {'append_to_log': False, 20:09:19 INFO - 'base_work_dir': '/builds/slave/test', 20:09:19 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:19 INFO - 'branch': 'Fx-Team', 20:09:19 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:19 INFO - 'config_files': ('talos/linux_config.py',), 20:09:19 INFO - 'default_actions': ('clobber', 20:09:19 INFO - 'read-buildbot-config', 20:09:19 INFO - 'download-and-extract', 20:09:19 INFO - 'populate-webroot', 20:09:19 INFO - 'create-virtualenv', 20:09:19 INFO - 'install', 20:09:19 INFO - 'run-tests'), 20:09:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:19 INFO - 'download_minidump_stackwalk': True, 20:09:19 INFO - 'download_symbols': 'ondemand', 20:09:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:19 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:19 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:19 INFO - 'installer_path': 'installer.exe', 20:09:19 INFO - 'log_level': 'info', 20:09:19 INFO - 'log_name': 'talos', 20:09:19 INFO - 'log_to_console': True, 20:09:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:19 INFO - 'opt_config_files': (), 20:09:19 INFO - 'pip_index': False, 20:09:19 INFO - 'sps_profile': False, 20:09:19 INFO - 'sps_profile_interval': 0, 20:09:19 INFO - 'suite': 'dromaeojs', 20:09:19 INFO - 'system_bits': '32', 20:09:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:19 INFO - 'title': 'talos-linux64-ix-062', 20:09:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:19 INFO - 'use_talos_json': True, 20:09:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:19 INFO - 'work_dir': 'build'} 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.387379Z] Running clobber step. 20:09:19 INFO - Running pre-action listener: _resource_record_pre_action 20:09:19 INFO - Running main action method: clobber 20:09:19 INFO - rmtree: /builds/slave/test/build 20:09:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:19 INFO - Running post-action listener: _resource_record_post_action 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.851468Z] Finished clobber step (success) 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.851569Z] Running read-buildbot-config step. 20:09:19 INFO - Running pre-action listener: _resource_record_pre_action 20:09:19 INFO - Running main action method: read_buildbot_config 20:09:19 INFO - Using buildbot properties: 20:09:19 INFO - { 20:09:19 INFO - "project": "", 20:09:19 INFO - "product": "firefox", 20:09:19 INFO - "script_repo_revision": "production", 20:09:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:09:19 INFO - "repository": "", 20:09:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:09:19 INFO - "buildid": "20160817173001", 20:09:19 INFO - "pgo_build": "True", 20:09:19 INFO - "basedir": "/builds/slave/test", 20:09:19 INFO - "buildnumber": 1475, 20:09:19 INFO - "slavename": "talos-linux64-ix-062", 20:09:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:09:19 INFO - "platform": "ubuntu64_hw", 20:09:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:19 INFO - "branch": "fx-team", 20:09:19 INFO - "repo_path": "integration/fx-team", 20:09:19 INFO - "revision": "11c94ec980d60a48be403d003798d64269e785ef", 20:09:19 INFO - "stage_platform": "linux64-pgo", 20:09:19 INFO - "builduid": "921c711a151f4d7e983975cc6adec061", 20:09:19 INFO - "slavebuilddir": "test" 20:09:19 INFO - } 20:09:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:09:19 INFO - Running post-action listener: _resource_record_post_action 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.853993Z] Finished read-buildbot-config step (success) 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.854081Z] Running download-and-extract step. 20:09:19 INFO - Running pre-action listener: _resource_record_pre_action 20:09:19 INFO - Running main action method: download_and_extract 20:09:19 INFO - mkdir: /builds/slave/test/build/tests 20:09:19 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')]} 20:09:19 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:09:19 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:20 INFO - Downloaded 1361 bytes. 20:09:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:09:20 INFO - Using the following test package requirements: 20:09:20 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:20 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:20 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:20 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'jsshell-linux-x86_64.zip'], 20:09:20 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:20 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:20 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:20 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:20 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:20 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09:20 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')]} 20:09:20 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:09:20 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:21 INFO - Downloaded 21908217 bytes. 20:09:21 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:09:25 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 20:09: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')]} 20:09:25 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:09:25 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:26 INFO - Downloaded 21908217 bytes. 20:09:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:09: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')]} 20:09:31 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:32 INFO - Downloaded 14413981 bytes. 20:09:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 20:09: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')]} 20:09:32 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:09:32 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:33 INFO - Downloaded 59612100 bytes. 20:09:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:09:33 INFO - mkdir: /builds/slave/test/properties 20:09:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:33 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:33 INFO - Contents: 20:09:33 INFO - build_url:https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:09:34 INFO - Running post-action listener: _resource_record_post_action 20:09:34 INFO - Running post-action listener: set_extra_try_arguments 20:09:34 INFO - [mozharness: 2016-08-18 03:09:34.398040Z] Finished download-and-extract step (success) 20:09:34 INFO - [mozharness: 2016-08-18 03:09:34.398263Z] Running populate-webroot step. 20:09:34 INFO - Running pre-action listener: _resource_record_pre_action 20:09:34 INFO - Running main action method: populate_webroot 20:09:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:34 INFO - '--tppagecycles', 20:09:34 INFO - '7'], 20:09:34 INFO - 'tests': ['tsvgm']}}, 20:09:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['damp', 'tps']}, 20:09:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'tests': ['damp', 'tps']}, 20:09:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['dromaeo_dom']}, 20:09:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['basic_compositor_video']}, 20:09:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:09:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['a11yr', 20:09:34 INFO - 'ts_paint', 20:09:34 INFO - 'tpaint', 20:09:34 INFO - 'sessionrestore', 20:09:34 INFO - 'sessionrestore_no_auto_restore', 20:09:34 INFO - 'tabpaint']}, 20:09:34 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:34 INFO - 'ts_paint', 20:09:34 INFO - 'tpaint', 20:09:34 INFO - 'sessionrestore', 20:09:34 INFO - 'sessionrestore_no_auto_restore', 20:09:34 INFO - 'tabpaint']}, 20:09:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:34 INFO - 'ts_paint', 20:09:34 INFO - 'tpaint', 20:09:34 INFO - 'sessionrestore', 20:09:34 INFO - 'sessionrestore_no_auto_restore', 20:09:34 INFO - 'tabpaint']}, 20:09:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:34 INFO - 'ts_paint', 20:09:34 INFO - 'tpaint', 20:09:34 INFO - 'sessionrestore', 20:09:34 INFO - 'sessionrestore_no_auto_restore', 20:09:34 INFO - 'tabpaint']}, 20:09:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['a11yr', 20:09:34 INFO - 'ts_paint', 20:09:34 INFO - 'tpaint', 20:09:34 INFO - 'sessionrestore', 20:09:34 INFO - 'sessionrestore_no_auto_restore', 20:09:34 INFO - 'tabpaint']}, 20:09:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['a11yr', 20:09:34 INFO - 'ts_paint', 20:09:34 INFO - 'tpaint', 20:09:34 INFO - 'sessionrestore', 20:09:34 INFO - 'sessionrestore_no_auto_restore', 20:09:34 INFO - 'tabpaint']}, 20:09:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['tsvgx', 20:09:34 INFO - 'tsvgr_opacity', 20:09:34 INFO - 'tart', 20:09:34 INFO - 'tscrollx', 20:09:34 INFO - 'cart']}, 20:09:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:34 INFO - 'tsvgr_opacity', 20:09:34 INFO - 'tart', 20:09:34 INFO - 'tscrollx', 20:09:34 INFO - 'cart']}, 20:09:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'talos_options': ['--disable-e10s'], 20:09:34 INFO - 'tests': ['tp5o']}, 20:09:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'tests': ['tp5o']}, 20:09:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'talos_options': ['--disable-e10s', 20:09:34 INFO - '--xperf_path', 20:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:34 INFO - 'tests': ['tp5n']}, 20:09:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:34 INFO - 'talos_options': ['--xperf_path', 20:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:34 INFO - 'tests': ['tp5n']}}, 20:09:34 INFO - 'talos.zip': {'path': '', 20:09:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:34 INFO - Running post-action listener: _resource_record_post_action 20:09:34 INFO - [mozharness: 2016-08-18 03:09:34.418502Z] Finished populate-webroot step (success) 20:09:34 INFO - [mozharness: 2016-08-18 03:09:34.418589Z] Running create-virtualenv step. 20:09:34 INFO - Running pre-action listener: _resource_record_pre_action 20:09:34 INFO - Running main action method: create_virtualenv 20:09:34 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:34 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 20:09:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:34 INFO - Using real prefix '/usr' 20:09:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:36 INFO - Installing pip.................done. 20:09:36 INFO - Return code: 0 20:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:09:36 INFO - Using env: {'DISPLAY': ':0', 20:09:36 INFO - 'HOME': '/home/cltbld', 20:09:36 INFO - 'LANG': 'en_US.UTF-8', 20:09:36 INFO - 'LANGUAGE': 'en_US:en', 20:09:36 INFO - 'LOGNAME': 'cltbld', 20:09:36 INFO - 'MAIL': '/var/mail/cltbld', 20:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:36 INFO - 'MOZ_NO_REMOTE': '1', 20:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:36 INFO - 'NO_EM_RESTART': '1', 20:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:36 INFO - 'PWD': '/builds/slave/test', 20:09:36 INFO - 'SHELL': '/bin/bash', 20:09:36 INFO - 'SHLVL': '1', 20:09:36 INFO - 'TERM': 'linux', 20:09:36 INFO - 'TMOUT': '86400', 20:09:36 INFO - 'USER': 'cltbld', 20:09:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:36 INFO - '_': '/tools/buildbot/bin/python'} 20:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:37 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 20:09:37 INFO - Cleaning up... 20:09:37 INFO - Return code: 0 20:09:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', '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 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:09: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 psutil>=3.1.1 20:09:37 INFO - Using env: {'DISPLAY': ':0', 20:09:37 INFO - 'HOME': '/home/cltbld', 20:09:37 INFO - 'LANG': 'en_US.UTF-8', 20:09:37 INFO - 'LANGUAGE': 'en_US:en', 20:09:37 INFO - 'LOGNAME': 'cltbld', 20:09:37 INFO - 'MAIL': '/var/mail/cltbld', 20:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:37 INFO - 'MOZ_NO_REMOTE': '1', 20:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:37 INFO - 'NO_EM_RESTART': '1', 20:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:37 INFO - 'PWD': '/builds/slave/test', 20:09:37 INFO - 'SHELL': '/bin/bash', 20:09:37 INFO - 'SHLVL': '1', 20:09:37 INFO - 'TERM': 'linux', 20:09:37 INFO - 'TMOUT': '86400', 20:09:37 INFO - 'USER': 'cltbld', 20:09:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:37 INFO - '_': '/tools/buildbot/bin/python'} 20:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:37 INFO - Downloading/unpacking psutil>=3.1.1 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:39 INFO - Installing collected packages: psutil 20:09:39 INFO - Running setup.py install for psutil 20:09:39 INFO - building 'psutil._psutil_linux' extension 20:09:39 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 20:09:39 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 20:09:39 INFO - building 'psutil._psutil_posix' extension 20:09:39 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 20:09:39 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 20:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:39 INFO - Successfully installed psutil 20:09:39 INFO - Cleaning up... 20:09:39 INFO - Return code: 0 20:09:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:09: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 mozsystemmonitor==0.3 20:09:39 INFO - Using env: {'DISPLAY': ':0', 20:09:39 INFO - 'HOME': '/home/cltbld', 20:09:39 INFO - 'LANG': 'en_US.UTF-8', 20:09:39 INFO - 'LANGUAGE': 'en_US:en', 20:09:39 INFO - 'LOGNAME': 'cltbld', 20:09:39 INFO - 'MAIL': '/var/mail/cltbld', 20:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:39 INFO - 'MOZ_NO_REMOTE': '1', 20:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:39 INFO - 'NO_EM_RESTART': '1', 20:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:39 INFO - 'PWD': '/builds/slave/test', 20:09:39 INFO - 'SHELL': '/bin/bash', 20:09:39 INFO - 'SHLVL': '1', 20:09:39 INFO - 'TERM': 'linux', 20:09:39 INFO - 'TMOUT': '86400', 20:09:39 INFO - 'USER': 'cltbld', 20:09:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:39 INFO - '_': '/tools/buildbot/bin/python'} 20:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:42 INFO - Installing collected packages: mozsystemmonitor 20:09:42 INFO - Running setup.py install for mozsystemmonitor 20:09:42 INFO - Successfully installed mozsystemmonitor 20:09:42 INFO - Cleaning up... 20:09:42 INFO - Return code: 0 20:09:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09:42 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')]} 20:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:42 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')]} 20:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:42 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 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:42 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 20:09:42 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 20:09:42 INFO - Using env: {'DISPLAY': ':0', 20:09:42 INFO - 'HOME': '/home/cltbld', 20:09:42 INFO - 'LANG': 'en_US.UTF-8', 20:09:42 INFO - 'LANGUAGE': 'en_US:en', 20:09:42 INFO - 'LOGNAME': 'cltbld', 20:09:42 INFO - 'MAIL': '/var/mail/cltbld', 20:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:42 INFO - 'MOZ_NO_REMOTE': '1', 20:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:42 INFO - 'NO_EM_RESTART': '1', 20:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:42 INFO - 'PWD': '/builds/slave/test', 20:09:42 INFO - 'SHELL': '/bin/bash', 20:09:42 INFO - 'SHLVL': '1', 20:09:42 INFO - 'TERM': 'linux', 20:09:42 INFO - 'TMOUT': '86400', 20:09:42 INFO - 'USER': 'cltbld', 20:09:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:42 INFO - '_': '/tools/buildbot/bin/python'} 20:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:42 INFO - Downloading/unpacking jsonschema==2.5.1 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:44 INFO - warning: no files found matching '*.txt' 20:09:44 INFO - no previously-included directories found matching 'build' 20:09:44 INFO - no previously-included directories found matching 'dist' 20:09:44 INFO - no previously-included directories found matching '.git*' 20:09:44 INFO - Installing collected packages: jsonschema, functools32 20:09:44 INFO - Running setup.py install for functools32 20:09:44 INFO - warning: no files found matching '*.txt' 20:09:44 INFO - no previously-included directories found matching 'build' 20:09:44 INFO - no previously-included directories found matching 'dist' 20:09:44 INFO - no previously-included directories found matching '.git*' 20:09:44 INFO - Successfully installed jsonschema functools32 20:09:44 INFO - Cleaning up... 20:09:44 INFO - Return code: 0 20:09:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:44 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 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:44 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 20:09:44 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 20:09:44 INFO - Using env: {'DISPLAY': ':0', 20:09:44 INFO - 'HOME': '/home/cltbld', 20:09:44 INFO - 'LANG': 'en_US.UTF-8', 20:09:44 INFO - 'LANGUAGE': 'en_US:en', 20:09:44 INFO - 'LOGNAME': 'cltbld', 20:09:44 INFO - 'MAIL': '/var/mail/cltbld', 20:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:44 INFO - 'MOZ_NO_REMOTE': '1', 20:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:44 INFO - 'NO_EM_RESTART': '1', 20:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:44 INFO - 'PWD': '/builds/slave/test', 20:09:44 INFO - 'SHELL': '/bin/bash', 20:09:44 INFO - 'SHLVL': '1', 20:09:44 INFO - 'TERM': 'linux', 20:09:44 INFO - 'TMOUT': '86400', 20:09:44 INFO - 'USER': 'cltbld', 20:09:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:44 INFO - '_': '/tools/buildbot/bin/python'} 20:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:09:45 INFO - Cleaning up... 20:09:45 INFO - Return code: 0 20:09:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:45 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 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:45 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 20:09:45 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 20:09:45 INFO - Using env: {'DISPLAY': ':0', 20:09:45 INFO - 'HOME': '/home/cltbld', 20:09:45 INFO - 'LANG': 'en_US.UTF-8', 20:09:45 INFO - 'LANGUAGE': 'en_US:en', 20:09:45 INFO - 'LOGNAME': 'cltbld', 20:09:45 INFO - 'MAIL': '/var/mail/cltbld', 20:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:45 INFO - 'MOZ_NO_REMOTE': '1', 20:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:45 INFO - 'NO_EM_RESTART': '1', 20:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:45 INFO - 'PWD': '/builds/slave/test', 20:09:45 INFO - 'SHELL': '/bin/bash', 20:09:45 INFO - 'SHLVL': '1', 20:09:45 INFO - 'TERM': 'linux', 20:09:45 INFO - 'TMOUT': '86400', 20:09:45 INFO - 'USER': 'cltbld', 20:09:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:45 INFO - '_': '/tools/buildbot/bin/python'} 20:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:45 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:47 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 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 20:09:47 INFO - Downloading docopt-0.6.1.tar.gz 20:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:47 INFO - Running setup.py install for blobuploader 20:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:47 INFO - Running setup.py install for requests 20:09:48 INFO - Running setup.py install for docopt 20:09:48 INFO - Successfully installed blobuploader requests docopt 20:09:48 INFO - Cleaning up... 20:09:48 INFO - Return code: 0 20:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:48 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 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:48 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 20:09:48 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 20:09:48 INFO - Using env: {'DISPLAY': ':0', 20:09:48 INFO - 'HOME': '/home/cltbld', 20:09:48 INFO - 'LANG': 'en_US.UTF-8', 20:09:48 INFO - 'LANGUAGE': 'en_US:en', 20:09:48 INFO - 'LOGNAME': 'cltbld', 20:09:48 INFO - 'MAIL': '/var/mail/cltbld', 20:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:48 INFO - 'MOZ_NO_REMOTE': '1', 20:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:48 INFO - 'NO_EM_RESTART': '1', 20:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:48 INFO - 'PWD': '/builds/slave/test', 20:09:48 INFO - 'SHELL': '/bin/bash', 20:09:48 INFO - 'SHLVL': '1', 20:09:48 INFO - 'TERM': 'linux', 20:09:48 INFO - 'TMOUT': '86400', 20:09:48 INFO - 'USER': 'cltbld', 20:09:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:48 INFO - '_': '/tools/buildbot/bin/python'} 20:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:48 INFO - Running setup.py (path:/tmp/pip-qZnJTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:48 INFO - Running setup.py (path:/tmp/pip-IMQfEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:48 INFO - Running setup.py (path:/tmp/pip-xOSf2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:48 INFO - Running setup.py (path:/tmp/pip-TAuYm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:49 INFO - Running setup.py (path:/tmp/pip-IshBAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:49 INFO - Running setup.py (path:/tmp/pip-Oiaa0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:49 INFO - Running setup.py (path:/tmp/pip-JZIet8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:49 INFO - Running setup.py (path:/tmp/pip-SHaWpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:49 INFO - Running setup.py (path:/tmp/pip-tforyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:49 INFO - Running setup.py (path:/tmp/pip-u6QluQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:49 INFO - Running setup.py (path:/tmp/pip-x8qpfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:49 INFO - Running setup.py (path:/tmp/pip-Rfohda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:49 INFO - Running setup.py (path:/tmp/pip-eOyGuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:49 INFO - Running setup.py (path:/tmp/pip-ELM9PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:49 INFO - Running setup.py (path:/tmp/pip-Mfeex4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:49 INFO - Running setup.py (path:/tmp/pip-hpgAve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:49 INFO - Running setup.py (path:/tmp/pip-vgBuqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:49 INFO - Running setup.py install for manifestparser 20:09:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozcrash 20:09:50 INFO - Running setup.py install for mozdebug 20:09:50 INFO - Running setup.py install for mozdevice 20:09:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozfile 20:09:50 INFO - Running setup.py install for mozhttpd 20:09:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozinfo 20:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozInstall 20:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozleak 20:09:50 INFO - Running setup.py install for mozlog 20:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Running setup.py install for moznetwork 20:09:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Running setup.py install for mozprocess 20:09:51 INFO - Running setup.py install for mozprofile 20:09:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Running setup.py install for mozrunner 20:09:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Running setup.py install for mozscreenshot 20:09:51 INFO - Running setup.py install for moztest 20:09:51 INFO - Running setup.py install for mozversion 20:09:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:51 INFO - Cleaning up... 20:09:51 INFO - Return code: 0 20:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:51 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')]} 20:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:51 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')]} 20:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:51 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 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:51 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 20:09:51 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 20:09:51 INFO - Using env: {'DISPLAY': ':0', 20:09:51 INFO - 'HOME': '/home/cltbld', 20:09:51 INFO - 'LANG': 'en_US.UTF-8', 20:09:51 INFO - 'LANGUAGE': 'en_US:en', 20:09:51 INFO - 'LOGNAME': 'cltbld', 20:09:51 INFO - 'MAIL': '/var/mail/cltbld', 20:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:51 INFO - 'MOZ_NO_REMOTE': '1', 20:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:51 INFO - 'NO_EM_RESTART': '1', 20:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:51 INFO - 'PWD': '/builds/slave/test', 20:09:51 INFO - 'SHELL': '/bin/bash', 20:09:51 INFO - 'SHLVL': '1', 20:09:51 INFO - 'TERM': 'linux', 20:09:51 INFO - 'TMOUT': '86400', 20:09:51 INFO - 'USER': 'cltbld', 20:09:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:51 INFO - '_': '/tools/buildbot/bin/python'} 20:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:51 INFO - Running setup.py (path:/tmp/pip-WRFRED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:52 INFO - Running setup.py (path:/tmp/pip-sdjxGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:52 INFO - Running setup.py (path:/tmp/pip-cMABQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:52 INFO - Running setup.py (path:/tmp/pip-CnEKrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:52 INFO - Running setup.py (path:/tmp/pip-ZQY2LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:52 INFO - Running setup.py (path:/tmp/pip-Egtv5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:52 INFO - Running setup.py (path:/tmp/pip-7Qwv12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:52 INFO - Running setup.py (path:/tmp/pip-00WtPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:52 INFO - Running setup.py (path:/tmp/pip-LhpzLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:52 INFO - Running setup.py (path:/tmp/pip-D6FnVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:52 INFO - Running setup.py (path:/tmp/pip-RLHIgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:52 INFO - Running setup.py (path:/tmp/pip-fokEVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:52 INFO - Running setup.py (path:/tmp/pip-bNlNKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:52 INFO - Running setup.py (path:/tmp/pip-PdYwZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:53 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)) 20:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:53 INFO - Running setup.py (path:/tmp/pip-DsDtv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:53 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)) 20:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:53 INFO - Running setup.py (path:/tmp/pip-ZtmjLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:53 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)) 20:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:53 INFO - Running setup.py (path:/tmp/pip-rw70Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:53 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 20:09:53 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 20:09:53 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 20:09:53 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 20:09:53 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 20:09:53 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 20:09:55 INFO - Downloading blessings-1.6.tar.gz 20:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:55 INFO - Installing collected packages: blessings 20:09:55 INFO - Running setup.py install for blessings 20:09:55 INFO - Successfully installed blessings 20:09:55 INFO - Cleaning up... 20:09:55 INFO - Return code: 0 20:09:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:55 INFO - Reading from file tmpfile_stdout 20:09:55 INFO - Current package versions: 20:09:55 INFO - argparse == 1.2.1 20:09:55 INFO - blessings == 1.6 20:09:55 INFO - blobuploader == 1.2.4 20:09:55 INFO - docopt == 0.6.1 20:09:55 INFO - functools32 == 3.2.3-2 20:09:55 INFO - jsonschema == 2.5.1 20:09:55 INFO - manifestparser == 1.1 20:09:55 INFO - mozInstall == 1.12 20:09:55 INFO - mozcrash == 0.17 20:09:55 INFO - mozdebug == 0.1 20:09:55 INFO - mozdevice == 0.48 20:09:55 INFO - mozfile == 1.2 20:09:55 INFO - mozhttpd == 0.7 20:09:55 INFO - mozinfo == 0.9 20:09:55 INFO - mozleak == 0.1 20:09:55 INFO - mozlog == 3.3 20:09:55 INFO - moznetwork == 0.27 20:09:55 INFO - mozprocess == 0.23 20:09:55 INFO - mozprofile == 0.28 20:09:55 INFO - mozrunner == 6.12 20:09:55 INFO - mozscreenshot == 0.1 20:09:55 INFO - mozsystemmonitor == 0.3 20:09:55 INFO - moztest == 0.7 20:09:55 INFO - mozversion == 1.4 20:09:55 INFO - psutil == 3.1.1 20:09:55 INFO - requests == 1.2.3 20:09:55 INFO - wsgiref == 0.1.2 20:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:55 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 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:55 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 20:09:55 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 20:09:55 INFO - Using env: {'DISPLAY': ':0', 20:09:55 INFO - 'HOME': '/home/cltbld', 20:09:55 INFO - 'LANG': 'en_US.UTF-8', 20:09:55 INFO - 'LANGUAGE': 'en_US:en', 20:09:55 INFO - 'LOGNAME': 'cltbld', 20:09:55 INFO - 'MAIL': '/var/mail/cltbld', 20:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:55 INFO - 'MOZ_NO_REMOTE': '1', 20:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:55 INFO - 'NO_EM_RESTART': '1', 20:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:55 INFO - 'PWD': '/builds/slave/test', 20:09:55 INFO - 'SHELL': '/bin/bash', 20:09:55 INFO - 'SHLVL': '1', 20:09:55 INFO - 'TERM': 'linux', 20:09:55 INFO - 'TMOUT': '86400', 20:09:55 INFO - 'USER': 'cltbld', 20:09:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:55 INFO - '_': '/tools/buildbot/bin/python'} 20:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 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)) 20:09:55 INFO - Cleaning up... 20:09:55 INFO - Return code: 0 20:09:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddbb2bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2807850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', '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 20:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:09:55 INFO - Using env: {'DISPLAY': ':0', 20:09:55 INFO - 'HOME': '/home/cltbld', 20:09:55 INFO - 'LANG': 'en_US.UTF-8', 20:09:55 INFO - 'LANGUAGE': 'en_US:en', 20:09:55 INFO - 'LOGNAME': 'cltbld', 20:09:55 INFO - 'MAIL': '/var/mail/cltbld', 20:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:55 INFO - 'MOZ_NO_REMOTE': '1', 20:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:55 INFO - 'NO_EM_RESTART': '1', 20:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:55 INFO - 'PWD': '/builds/slave/test', 20:09:55 INFO - 'SHELL': '/bin/bash', 20:09:55 INFO - 'SHLVL': '1', 20:09:55 INFO - 'TERM': 'linux', 20:09:55 INFO - 'TMOUT': '86400', 20:09:55 INFO - 'USER': 'cltbld', 20:09:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:55 INFO - '_': '/tools/buildbot/bin/python'} 20:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:09:56 INFO - Cleaning up... 20:09:56 INFO - Return code: 0 20:09:56 INFO - Running post-action listener: _resource_record_post_action 20:09:56 INFO - Running post-action listener: _start_resource_monitoring 20:09:56 INFO - Starting resource monitoring. 20:09:56 INFO - [mozharness: 2016-08-18 03:09:56.094631Z] Finished create-virtualenv step (success) 20:09:56 INFO - [mozharness: 2016-08-18 03:09:56.095085Z] Running install step. 20:09:56 INFO - Running pre-action listener: _resource_record_pre_action 20:09:56 INFO - Running main action method: install 20:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:56 INFO - Reading from file tmpfile_stdout 20:09:56 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:56 INFO - Reading from file tmpfile_stdout 20:09:56 INFO - Output received: 20:09:56 INFO - Usage: mozinstall [options] installer 20:09:56 INFO - Options: 20:09:56 INFO - -h, --help show this help message and exit 20:09:56 INFO - -d DEST, --destination=DEST 20:09:56 INFO - Directory to install application into. [default: 20:09:56 INFO - "/builds/slave/test"] 20:09:56 INFO - --app=APP Application being installed. [default: firefox] 20:09:56 INFO - mkdir: /builds/slave/test/build/application 20:09:56 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'] 20:09:56 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 20:10:13 INFO - Reading from file tmpfile_stdout 20:10:13 INFO - Output received: 20:10:13 INFO - /builds/slave/test/build/application/firefox/firefox 20:10:13 INFO - Running post-action listener: _resource_record_post_action 20:10:13 INFO - [mozharness: 2016-08-18 03:10:13.375963Z] Finished install step (success) 20:10:13 INFO - [mozharness: 2016-08-18 03:10:13.376208Z] Running run-tests step. 20:10:13 INFO - Running pre-action listener: _resource_record_pre_action 20:10:13 INFO - Running main action method: run_tests 20:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:10:13 INFO - Python 2.7.3 20:10:13 INFO - Return code: 0 20:10:13 INFO - grabbing minidump binary from tooltool 20:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:13 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 0x2802370>, '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 0x28058f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2805d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:10:13 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 20:10:13 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 20:10:13 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 20:10:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:13 INFO - Return code: 0 20:10:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:10:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:10:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:10:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:10:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 20:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 20:10:13 INFO - Using env: {'DISPLAY': ':0', 20:10:13 INFO - 'HOME': '/home/cltbld', 20:10:13 INFO - 'LANG': 'en_US.UTF-8', 20:10:13 INFO - 'LANGUAGE': 'en_US:en', 20:10:13 INFO - 'LOGNAME': 'cltbld', 20:10:13 INFO - 'MAIL': '/var/mail/cltbld', 20:10:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:10:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:13 INFO - 'MOZ_NO_REMOTE': '1', 20:10:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:13 INFO - 'NO_EM_RESTART': '1', 20:10:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:13 INFO - 'PWD': '/builds/slave/test', 20:10:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:10:13 INFO - 'SHELL': '/bin/bash', 20:10:13 INFO - 'SHLVL': '1', 20:10:13 INFO - 'TERM': 'linux', 20:10:13 INFO - 'TMOUT': '86400', 20:10:13 INFO - 'USER': 'cltbld', 20:10:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689', 20:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:13 INFO - '_': '/tools/buildbot/bin/python'} 20:10:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 20:10:13 INFO - mozversion application_buildid: 20160817173001 20:10:13 INFO - mozversion application_changeset: 11c94ec980d60a48be403d003798d64269e785ef 20:10:13 INFO - mozversion application_display_name: Nightly 20:10:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:13 INFO - mozversion application_name: Firefox 20:10:13 INFO - mozversion application_remotingname: firefox 20:10:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:10:13 INFO - mozversion application_vendor: Mozilla 20:10:13 INFO - mozversion application_version: 51.0a1 20:10:13 INFO - mozversion platform_buildid: 20160817173001 20:10:13 INFO - mozversion platform_changeset: 11c94ec980d60a48be403d003798d64269e785ef 20:10:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:10:13 INFO - mozversion platform_version: 51.0a1 20:10:13 INFO - using testdate: 1471489813 20:10:13 INFO - actual date: 1471489813 20:10:13 INFO - starting webserver on 'localhost:55267' 20:10:13 INFO - SUITE-START | Running 2 tests 20:10:13 INFO - TEST-START | dromaeo_css 20:10:13 INFO - operating with platform_type : linux_ 20:10:13 INFO - Initialising browser for dromaeo_css test... 20:10:13 INFO - TEST-INFO | started process 27842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIymj5B/profile http://localhost:55267/getInfo.html) 20:10:17 INFO - PROCESS | 27842 | __metrics Screen width/height:1600/1200 20:10:17 INFO - PROCESS | 27842 | colorDepth:24 20:10:17 INFO - PROCESS | 27842 | Browser inner width/height: 1024/697 20:10:17 INFO - PROCESS | 27842 | __metrics 20:10:17 INFO - PROCESS | 27842 | 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" 20:10:17 INFO - PROCESS | 27842 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:18 INFO - PROCESS | 27842 | console.error: PushService: 20:10:18 INFO - PROCESS | 27842 | stateChangeProcessEnqueue: Error transitioning state 20:10:18 INFO - PROCESS | 27842 | UnknownError 20:10:18 INFO - TEST-INFO | 27842: exit 0 20:10:18 INFO - Browser initialized. 20:10:18 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:18 INFO - TEST-INFO | started process 27924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIymj5B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:30 INFO - PROCESS | 27924 | RSS: Main: 155897856 20:10:30 INFO - PROCESS | 27924 | 20:11:22 INFO - PROCESS | 27924 | 1471489882079 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] 20:13:31 INFO - PROCESS | 27924 | Cycle 1(1): loaded http://localhost:55267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55267/tests/dromaeo/cssquery-ext.html) 20:13:32 INFO - PROCESS | 27924 | RSS: Main: 254631936 20:13:32 INFO - PROCESS | 27924 | 20:16:34 INFO - PROCESS | 27924 | Cycle 1(1): loaded http://localhost:55267/tests/dromaeo/cssquery-ext.html (next: http://localhost:55267/tests/dromaeo/cssquery-jquery.html) 20:16:35 INFO - PROCESS | 27924 | RSS: Main: 249503744 20:16:35 INFO - PROCESS | 27924 | 20:19:37 INFO - PROCESS | 27924 | Cycle 1(1): loaded http://localhost:55267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55267/tests/dromaeo/cssquery-mootools.html) 20:19:37 INFO - PROCESS | 27924 | RSS: Main: 185323520 20:19:37 INFO - PROCESS | 27924 | 20:22:39 INFO - PROCESS | 27924 | Cycle 1(1): loaded http://localhost:55267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55267/tests/dromaeo/cssquery-prototype.html) 20:22:40 INFO - PROCESS | 27924 | RSS: Main: 192507904 20:22:40 INFO - PROCESS | 27924 | 20:25:43 INFO - PROCESS | 27924 | Cycle 1(1): loaded http://localhost:55267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55267/tests/dromaeo/cssquery-yui.html) 20:25:43 INFO - PROCESS | 27924 | RSS: Main: 185982976 20:25:43 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | Cycle 1(1): loaded http://localhost:55267/tests/dromaeo/cssquery-yui.html (next: http://localhost:55267/tests/dromaeo/cssquery-dojo.html) 20:28:47 INFO - PROCESS | 27924 | RSS: Main: 277118976 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | __start_tp_report 20:28:47 INFO - PROCESS | 27924 | _x_x_mozilla_page_load 20:28:47 INFO - PROCESS | 27924 | _x_x_mozilla_page_load_details 20:28:47 INFO - PROCESS | 27924 | |i|pagename|runs| 20:28:47 INFO - PROCESS | 27924 | |0;dojo.html;2969.8515074246284;2985.865636046378;3009.428208640358;3021.7280444759967;3027.1675289295454;5140;5176.844694659157;5204.167333226685;5230.529252367286;5248.737563121843;5203.453637368069;5221.556167725748;5260.92108618371;5282.973585132078;5316.282301889244;4759.90480190396;4793.712377257376;4796.400449943757;4798.184308667535;4950.034743225073;4865.440474345442;4891.192953162724;4895.755212239392;4919.606431485473;4941.678790878599;4699.295105734133;4731.077439899221;4762.857114286577;4763.166445871959;4765.09463201994;4740.928886066712;4770.260609605517;4770.284457331393;4779.522047795227;4795.736234507101;4726.409198850144;4756.215224487955;4782.282657601353;4860.198067318888;4866.975665121687;5086.694798312114;5302.92045619316;5320.707361095138;5354.785808567653;5356.035913535562;5520.1443776214755;5565.916511252334;5582.86042848928;5623.381428042912;5670.347909990322;5587.273654424939;5632.155176723483;5652.3217213934595;5706.629069110536;5716.514096301819;5159.1229490986625;5172;5289.338832645958;5319.414864364917;5346.866328341784;5660.8867822643315;5678.801241956512;5712.143178523254;5716.714164291769;5763.991301522216;5536.114221724585;5548.944510554843;5551.639143455663;5560.638558493685;5567.860803479945;5459.69971651555;5503.834884953458;5591.776328946878;5600.075987462104;5637.830865074055;5533.916991245134;5571.13647384656;5572.498475137257;5622.803201887914;5632.887342253214;5540.833774986757;5560;5569.498745112959;5574.60977731563;5574.60977731563;4190.392393102983;4199.076203235283;4317.093410383792;4324.978375108167;4331.7834108294455;3809.5999920008;3822.4266360046217;3854.71089668276;3864.6328598783634;3932.9016774580864;5266.1574148136115;5293.550048245866;5297.099493086184;5331.86670333237;5345.679259244458;5469.097598896137;5556.527695145877;5565.193047008162;5586.664800112007;5597.524210442158;5181.119209734279;5195.844124676266;5216.374035115735;5280.867978300574;5294.047071527162;4811.807527698853;4816.686915350491;4820.9517904820505;4840.346553215341;4856.1016212000895;5573.693446860299;5829.825105246934;5829.912551311733;5833.562482813806;5854.121881717776;5554.50009499147;5586.636868603528;5589.608727389043;5628.943710563006;5702.657840529581;5827.329857066492;5835.824925252249;5837.241158649348;5840.503557197686;5842.853928651818;5255.973720131375;5517.44825517445;5537.750801213874;5537.889242215214;5543.1408131739645;5436.619436639556;5446.319210098738;5449.455054494519;5586.245856809279;5628;5408.648437851527;5426.8371948841595;5430.40265570779;5462.781488740406;5469.644473109235;5334;5340.198970154508;5355.946440535545;5371.328583927009;5385.8922821542565;5330.360356757214;5380.946190538201;5436.293281873489;5463.235147079492;5472.179173124063;5497.065498865282;5508.338999320107;5523.1991361253195;5548.195511650869;5554.666719996813;5274.551663108678;5383.650062745909;5398.217258497417;5398.325209348832;5403.7838486460105 20:28:47 INFO - PROCESS | 27924 | |1;ext.html;563.8909429191611;570.3725901508342;573.6156774960776;576.700115939711;603.7041849493746;32873.34253314932;43286;43840.3423948641;44008.77995610022;44047;46525.53474465254;46973.29540056902;47011.294830577484;47333;47375.76312118435;8916.777080572989;9061.728148155566;9076.273898088137;9087.454752714859;9091.772705682344;8832.646694132227;8954.552272386387;8986.86519702205;8989.41568798026;8992.77518062047;9016.909830901706;9052.230560402373;9076.682316118937;9077.95461022694;9079.455232686027;8983.146601072887;9037.909620903805;9059.048799875984;9060.909390906072;9066.320025998044;8902.73291801247;8971.955140224323;8976.910230897673;8982.10178982103;8984.146506081977;42986;43765.78117109394;43771;43864.561354386366;43908;3548.822558872046;3768.340540405418;3781.7920014399197;4012.859549915739;4034.7780872052026;32058.679413206035;32440.837795811105;33434.83282583596;33780.49329260038;34532.309353813034;4309.892252693708;4403.119376124756;4409.5149533551285;4585.060062687141;4672.486026537078;336868;338402;339611.30194349115;339651;342557;58015.709921450965;58244;58250.41749582535;58698.70650646719;58719.706401467716;61844.690776546726;61866.38133618606;61897;61915.38084619186;61988.380116199165;16346.264418100976;16570.502884913472;16591.41930032443;16595.585110372336;16624.584385390463;12221.69445763863;12231.449584768707;12235.449404776806;12255.571055013032;12256.938715306367;17044.403445879336;17214.569635759206;17293.56766080833;17373;17440.12799360027;6138.539609529304;6359.682015899187;6387.233531976192;6447.226332839996;6473.158489396348;947.9571523367155;978.951052447389;995.144176008632;995.3132338686428;1047.7171163785736;31294.56884325766;31379.68620313813;31850.362992740014;31899.84050079781;32372;1051.7107795356185;1082.2153938394758;1124.662601219631;1157.3287493253893;1208.915375923677;16176.595585110466;16726.581835453966;16752.162391880356;16762.74855877163;17334.47996560105;525397;531221;531474;531706;531924;61088;61214.69392653008;61215.69392153011;61323;61835;1217.7929751942013;1327.8141060251573;1335.833020872391;1361.4282001559368;1365.044468871774;29994.501374656335;35345;35587.82206089057;35673.28653426865;35775.64224357827;53345.733271333396;54228;54268.64328391664;54293.185602216785;54331.45668543264;500521;506804;506948;507754;509922;44920.77539612412;45289.773551132035;46593;46741.76629116833;46798.76600616975;49344.259836101766;49797.50202497929;50321.49678503168;50428.243576347115;50544.747276263384;40976.590234097275;41377.793111034254;41708;42828.357574637026;43201.13597727965;41690.79154604208;41747.37378939258;42262.366064509675;43626.34560481532;43865.34201986909;43272.35091473693;44675.77662111669;44716.77641611771;44750.10499790051;44757.77621111873;35332.64667353294;37361.81319093496;37462.8126859364;37945.81027094847;38297;29103.272418188866;29504.262393440335;29515;29583.704162958096;29765.553516696833 20:28:47 INFO - PROCESS | 27924 | |2;jquery.html;356.5097990263388;375.81021584100034;380.1996796742856;386.2140543992974;402.832824377883;14527.854721452795;18883.716744248846;19403.223871045142;19988.500287492785;20194.798052019512;18541.629167416642;19659.803401965975;19770.604587908234;19812.603747925034;20292.797072029276;5511.696856672881;5746.770129194827;5758.107493338518;5766.394528574502;5779.450952159538;5499.395066542677;5625.971870140644;5685.829425117253;5705.2012718219485;5711.828645140632;5614;5673.092305231164;5685;5693.060644993571;5695.743691533891;5504.6421982571;5572.58205634579;5597.104463285896;5597.468240517144;5609.691466969315;4970.676906001098;4973.651844370896;4980.551750342486;4982.850514484535;4991;23932.641010384858;23986.160484382963;24016.399590010216;24024.519509609883;24128.879355603287;2345.906163753448;2433.270018994295;2517.992802878845;2594.299539124426;3038.8024778389554;14476;14916.254187290591;15032.248387580687;15077.47228846996;15178.31697573612;1895.4029480713532;1971.9112639931238;1972.4477146398888;1978.169168949045;2008.4878356019267;52893.47106528924;57689.71155144197;79159.20840791633;79394.60302698449;80780.59609701914;9635.807283854283;9717.951410243046;9928.602855885829;10491.16070714341;11049.834252486218;14528.927355363156;14595.343209555384;14608;14639.92680036593;14652.560423187322;7876.684932602631;7985.840283194304;8086.393520485987;8310;8312.376571757142;7625.733099341496;7785.610719464004;7822.882656760153;7838.412119091091;8004.919950800534;6269.905951410732;6379.266384365857;6463.545702216964;6543.476521878239;6579.80260592183;1794.7487351770762;1810.8722251354607;1816.609428972777;1844.4743248174207;1857.944261672152;926.6293482607011;1053.7787064716495;1058.1534772182224;1064.4624464645306;1069.7432616172064;20155.39533813988;20685.33906849916;20741.170353186004;20816.583668326548;21061.052252648362;992.1417973452911;1045.4877110216091;1051.2273478992934;1064.535600085799;1086.2342048855537;11056.502457389437;11543.307401555934;11729.765404692029;11896.821547676791;11922.523099076114;485596;491064;502857;506130;511743;81354.59322703349;81430;82898;82945;83325;990.1583653894132;997.9720887485901;1015.0610685116238;1015.4973288222377;1017.1354348803605;17713.468595942144;17909.283628654706;18108.818911810715;18582.535436614195;18879.244830207186;40966.590334096276;40984.38523422211;41523.58476415197;41712.3743143847;42030.1593968125;53793.73103134459;53799.73100134474;54617.99202087847;55389.44610553843;56400.71799640975;8178.754637360888;8286.378521611025;8360.498370097814;8487.108853570286;8549.879294057748;12998.285094319524;13136.408861601441;13150.671233219246;13221.338933053501;13316.933415332862;11332.943335283271;11529.711757205801;11637.069034477052;11996.920277175097;12352.3823808811;11215.775684486427;11256.662300131009;11473.885261147281;11646.359450230319;11674.70813229676;11789.351585662871;11826.172167948162;11961.820572691591;11969.521219151136;12217.755644887231;7238.457115716447;7587.127480339611;7741.380689544935;8218.137095604876;8513.233808957224;9077.31920106008;11568.595099171489;11814.232074915102;11826.231294965799;11972.221805582609 20:28:47 INFO - PROCESS | 27924 | |3;mootools.html;1279.3858947705107;1463.2903042024616;1508.0951429142515;1642.203531287326;1772.1759381887412;7871.9606401967985;8187.959060204698;8203.835923281538;8418.66325346987;8425.410221284512;8300.335973122152;8389.035260944993;8410.074891761902;8415.116412776662;8495.660173593064;2104.042660589428;2116.100657220679;2126.4258650164447;2126.479012641897;2136.7970042845905;2313.4563377606332;2335.1243283768586;2344.0623750499767;2346.730126035502;2354.505553833697;2310.1336998625516;2313.421644588853;2318.107528601492;2318.547883162784;2357.2574638988663;2245.831562632809;2299.298713892262;2300.9654855177187;2301.091069027733;2301.735300440454;2236.7763223677503;2255.853369530975;2277.578647950118;2284.4060544258446;2290.7365652949793;8182.509049457051;8188.344932405394;8240.258376746062;8248.628811703487;8283.08886022537;4770.0698363819065;4999.3000979862845;5001.199808030734;5002.574781143607;5009.198528235502;3298.6041674998914;3362.7309815214726;3365.9831700841582;3454.0501362125365;3476.8435420406145;1076.580133747839;1125.5272785430138;1152.3661985907802;1169.8713141554422;1180.1208099965495;11349.432528373549;11350.318980861175;11374.260673056307;11428.428578571122;11472;4164.333706606928;4327.956720432755;4329.437173167468;4440.777961101997;4452.354408610733;9132.817343653223;9136.132067453582;9146.90853091474;9158.267338613028;9158.40470369424;4937.432195297515;4951.257311403247;4956.826511072168;4957.157283261854;4960.280759289883;4024.557298697141;4247.17180149874;4627.791749371287;4631.0506346198945;4635.513271106553;3537.7346698997676;3548.946765798515;3645.744797864177;3652.4521321801944;3683.465897444909;1054.7679510507676;1089.4443833644898;1096.9177311701494;1098.1653943003375;1101.1191047162238;915.0757734688013;925.5973651461636;937.3727744844024;949.368669834566;967.56943160293;5588.832335029955;5595.804146854841;5730.713464326767;5855.970720146372;5857.179994800731;956.1776871890169;985.6106837799173;997.6458357283205;1003.2726273451689;1016.3546148195949;3752.4614907887635;4010.939835902464;4022.9798851005557;4029.2545879012478;4174.286713636161;10024.298299118991;10135;10481.423521706227;10489.108425783894;10492.370457772558;10264.743381415525;10392.532336044897;10397;10424.895751042544;10437.165026797838;7800.297973182441;7841.137474877759;7905.288524032865;7928.167542407964;7936.007999000125;5610.438956104357;5691.8292451226525;5695.943040569541;5752.712364381848;6016.2780466342565;9149.451032938045;9353.25173986093;9466.195373393339;9497.24022078246;9605.615775368908;9204.493752843659;9366.859497107685;9609.087136722;9664.323497355117;9717.125458708468;7444.143923448656;7587.165411804807;7591.202923693154;7595.962020190084;7598.784194528849;7733.961330193313;8034.116247212919;8154.347652187692;8317.792055198668;8319.126491718282;7183.640817959185;7261.164966028974;7298.854022919618;7348.375388091858;7436.851262974602;7186.065811444479;7242.058532390755;7315.853682926205;7380.667869945973;7386.704531818667;6720.294369091175;6739.157605299338;6751.122354094133;6806.829829254309;6887.621180835102;4617.953820461887;4643.257078867365;4786.904261914812;4797.616190704665;4831.06634413296;4926.187179115406;4992.226204938241;5014.473480284663;5073.315102461268;5264.184051472028 20:28:47 INFO - PROCESS | 27924 | |4;prototype.html;293.2756092451645;311.67430035612784;317.16743548186014;319.8752486530253;331.6716450713793;5162.896742065156;5182.144946083901;5190.506901844319;5205.453427390126;5213.478652134785;4869.391326084239;4937.136001199785;5018.774155163017;5072.51811077947;5105.897882042357;4034.3746719258415;4034.5965403459713;4043.231785960673;4043.312636851735;4049.1699201663587;4037.4347591337237;4062.8715888765632;4068.820042187762;4075.673946084306;4088.6524645405175;3799.3920972644382;3865.246276975977;3984.163325701606;4015.7389769665024;4038.5759495253014;3945.053187235057;3958.4656071430563;3964.960350396488;3979.214549815112;3999.580044095357;3561.6082230954576;3564.3940530109944;3565.94651080234;3566;3569.94645080324;4742.644301677354;4934.654574179773;4942.406911170647;4957.231629097496;4977.278294647292;4464.754438505881;4467.597916187558;4470.173017991682;4485.699147247295;4501.144782491317;5295.814646487393;5319.521243088102;5324.254604355393;5331.173668081454;5354.303940487751;3645.9270814583824;3778.6410291022307;3782.3002744492355;3808.980955095207;3814.179951310454;5489.890202195934;5525.198846167324;5538.224648549206;5549.639273447254;5602.215689803431;3976.304146774303;3979.323515002399;3993.4608827808456;4001.239764444746;4006.6994975376965;4033.415154802537;4038.5355684096703;4059.9797001014804;4067.7355971861734;4081.10215752534;4428.269335559661;4496.685232033792;4524.886877828015;4528.166092732448;4578.267477203632;5263.526282634504;5265.921011184835;5276.07178016197;5305.469453054741;5341.385740639798;1350.3990724127668;1365.863413658626;1366.5285476510587;1366.9453221871213;1391.304347826087;855.4696088425092;924.3021518753299;942.7124726958207;962.100436092256;963.494165563071;5165.638405311592;5171.707073231692;5185.196294574347;5194.792208311701;5199;5427.158790387496;5447.700376479253;5461.590380721462;5504.2294078829;5534.52956498694;4982.4768399317545;5065.442801291855;5125.769340379692;5177.171652535651;5183.922241166386;2841.0624493916957;2884.293348129722;2900.4489147062413;2907.5752881088115;2909;5500.58745594074;5660.4622111180515;5711.628744131618;5719.428057194247;5748.166515855261;5595.125632912938;5602;5606.747696353674;5614.522765564972;5621.662700237999;5661.179129026268;5668.829935101953;5671.695510032716;5699.82900512977;5747.166660834239;5197.064528384927;5443.972780136074;5498.5876059294915;5539.362973258127;5561.416051314553;5457.399686034612;5487.506124448819;5489.490390142742;5489.560835133259;5495.477929596682;5653.915191272216;5695.73265494007;5701.315842098975;5721.456461636138;5753.338366087954;3866.5553461352306;3904.9609503905735;3959.386295124145;3962.8018599070506;3966.960330396659;5465;5490.286262785812;5490.313710786152;5514.36584792754;5523.861903452445;5273.709945952856;5395.4604539545735;5423.613610011582;5426.620136590559;5431.402545720047;5256.264123022704;5307.867303317294;5351.357837059422;5360.946390536044;5365.22204280385;5120.667156634807;5209.661372010959;5347.652402593819;5349.973250133725;5362.785488580413;5368.651037682538;5393.649412788156;5421;5430.294061771944;5438.918416223681;5282.762275697526;5304.655197412156;5306.8407947761625;5311.468853114812;5330.387005494418 20:28:47 INFO - PROCESS | 27924 | |5;yui.html;744.4230721191079;767.2902565127256;776.1346099099505;811.3306522119253;843.2832092721186;13564.253966031863;15256.160911149882;15295.311710973005;15314;15385.846141538595;15484.69030619387;15636.061836289831;15649.45226917058;15654.84345156548;15659.13874736889;642.3255581639272;669.3674477618653;670.6177478837064;673.4006734006738;783.9686412543491;809.3161278719473;818.1654712193559;820.2822530285999;825.3850881093593;827.0943317067831;872.2934423117264;873.52829472085;874.6020560644923;874.921257086862;875.011237301848;674.3391476353153;869.9782505437352;872.5244741615835;875.3259989807844;875.4659657608853;614.6895817612123;634.4765568406037;637.1366797988751;638.7987783848073;639.7792761497276;14820.777688334683;14847.851521484756;14850.480233191895;14858.405663773436;14887.47893823711;14203.502877399345;14597.270136493238;14989.550313490612;15276.083434993936;15282.388704451809;13597.86402135976;13618.727625447535;13836.723265534632;14053;14256;4286.421333120051;4339.305711086211;4493.707908985938;4559.17934771741;4573.542645735433;77948.61025694892;79330;79611;79789.20210797875;80370;11595.76808463826;11636.592719254786;11688.590899318484;11945.16383853122;12109.697257568456;22305.665415018786;22378.44053898633;22381;22382.776172238067;22396.55206895853;8236.876446853303;8710.128987101365;8809;8976.730698079067;9075.773105672279;4720.386349774507;4863.367762190964;4963.528464795839;5137.17805151174;5205.6616319939085;3280.458724310462;3656.7257455690396;3800.733948623625;3811.19964807388;3861.768293902375;614.0942110387143;617.6232498176109;618.811262564922;641.0224407778082;651.664392837689;640.8365866703961;674.7348721147848;679.0662838596929;749.0935967479302;754.5849782619538;10317.587296508205;10343.951582775084;10815.459227038617;10837.241393102564;10856.457177141112;623.1618473153601;642.2934771751037;707.4587940225731;757.81812365032;772.1660606544918;4833.419989601271;5008.824691135793;5043.218301163325;5045.924311135336;5193.506616871391;72078.63960680268;82599.39204863597;83971;129310;130185.34907325402;85290.57354713311;85609;86832;105210.4739476313;109833.40999540054;54116.18825717539;55939.16091258635;77499.61250193712;83264.58367708123;86493.56753216193;9955.751106222402;10208.54061567246;10422.114120299859;10640.361578305326;11028;48496.5150348492;49897.75051124721;50508;51059.74470127626;52676.473235267156;72126.27873721195;77769.61115194387;78038.87844486385;79148;79655;13125.60623181306;13385.66535836573;13501.392437340146;13764.105333153313;13991.300434978413;15322.693546129238;15542.378304867678;16162.040300126544;16662.83337166613;16868;13939.233342166279;14092.436302547783;15595.220238988231;15607;15777.132257725936;13984.720305593628;14799;15362;15688.921555392606;15702.842971570139;14031.228282444563;14179.574612761633;14994.400223990919;15321.339330334833;15433.382664693736;11363;11421.029212516696;11511.712207194887;11820.23168494045;12264.816027759412;11708.297502149899;11801.29192248468;11940.820887686517;12007.459664314953;12112.576059837864 20:28:47 INFO - PROCESS | 27924 | __end_tp_report 20:28:47 INFO - PROCESS | 27924 | __start_cc_report 20:28:47 INFO - PROCESS | 27924 | _x_x_mozilla_cycle_collect,983 20:28:47 INFO - PROCESS | 27924 | __end_cc_report 20:28:47 INFO - PROCESS | 27924 | __startTimestamp1471490927356__endTimestamp 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | ------- Summary: start ------- 20:28:47 INFO - PROCESS | 27924 | Number of tests: 6 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | [#0] dojo.html Cycles:165 Average:5201.37 Median:5380.95 stddev:583.58 (10.8%) stddev-sans-first:558.50 20:28:47 INFO - PROCESS | 27924 | Values: 2969.9 2985.9 3009.4 3021.7 3027.2 5140.0 5176.8 5204.2 5230.5 5248.7 5203.5 5221.6 5260.9 5283.0 5316.3 4759.9 4793.7 4796.4 4798.2 4950.0 4865.4 4891.2 4895.8 4919.6 4941.7 4699.3 4731.1 4762.9 4763.2 4765.1 4740.9 4770.3 4770.3 4779.5 4795.7 4726.4 4756.2 4782.3 4860.2 4867.0 5086.7 5302.9 5320.7 5354.8 5356.0 5520.1 5565.9 5582.9 5623.4 5670.3 5587.3 5632.2 5652.3 5706.6 5716.5 5159.1 5172.0 5289.3 5319.4 5346.9 5660.9 5678.8 5712.1 5716.7 5764.0 5536.1 5548.9 5551.6 5560.6 5567.9 5459.7 5503.8 5591.8 5600.1 5637.8 5533.9 5571.1 5572.5 5622.8 5632.9 5540.8 5560.0 5569.5 5574.6 5574.6 4190.4 4199.1 4317.1 4325.0 4331.8 3809.6 3822.4 3854.7 3864.6 3932.9 5266.2 5293.6 5297.1 5331.9 5345.7 5469.1 5556.5 5565.2 5586.7 5597.5 5181.1 5195.8 5216.4 5280.9 5294.0 4811.8 4816.7 4821.0 4840.3 4856.1 5573.7 5829.8 5829.9 5833.6 5854.1 5554.5 5586.6 5589.6 5628.9 5702.7 5827.3 5835.8 5837.2 5840.5 5842.9 5256.0 5517.4 5537.8 5537.9 5543.1 5436.6 5446.3 5449.5 5586.2 5628.0 5408.6 5426.8 5430.4 5462.8 5469.6 5334.0 5340.2 5355.9 5371.3 5385.9 5330.4 5380.9 5436.3 5463.2 5472.2 5497.1 5508.3 5523.2 5548.2 5554.7 5274.6 5383.7 5398.2 5398.3 5403.8 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | [#1] ext.html Cycles:180 Average:62840.15 Median:44696.28 stddev:123700.97 (276.8%) stddev-sans-first:123959.61 20:28:47 INFO - PROCESS | 27924 | Values: 563.9 570.4 573.6 576.7 603.7 32873.3 43286.0 43840.3 44008.8 44047.0 46525.5 46973.3 47011.3 47333.0 47375.8 8916.8 9061.7 9076.3 9087.5 9091.8 8832.6 8954.6 8986.9 8989.4 8992.8 9016.9 9052.2 9076.7 9078.0 9079.5 8983.1 9037.9 9059.0 9060.9 9066.3 8902.7 8972.0 8976.9 8982.1 8984.1 42986.0 43765.8 43771.0 43864.6 43908.0 3548.8 3768.3 3781.8 4012.9 4034.8 32058.7 32440.8 33434.8 33780.5 34532.3 4309.9 4403.1 4409.5 4585.1 4672.5 336868.0 338402.0 339611.3 339651.0 342557.0 58015.7 58244.0 58250.4 58698.7 58719.7 61844.7 61866.4 61897.0 61915.4 61988.4 16346.3 16570.5 16591.4 16595.6 16624.6 12221.7 12231.4 12235.4 12255.6 12256.9 17044.4 17214.6 17293.6 17373.0 17440.1 6138.5 6359.7 6387.2 6447.2 6473.2 948.0 979.0 995.1 995.3 1047.7 31294.6 31379.7 31850.4 31899.8 32372.0 1051.7 1082.2 1124.7 1157.3 1208.9 16176.6 16726.6 16752.2 16762.7 17334.5 525397.0 531221.0 531474.0 531706.0 531924.0 61088.0 61214.7 61215.7 61323.0 61835.0 1217.8 1327.8 1335.8 1361.4 1365.0 29994.5 35345.0 35587.8 35673.3 35775.6 53345.7 54228.0 54268.6 54293.2 54331.5 500521.0 506804.0 506948.0 507754.0 509922.0 44920.8 45289.8 46593.0 46741.8 46798.8 49344.3 49797.5 50321.5 50428.2 50544.7 40976.6 41377.8 41708.0 42828.4 43201.1 41690.8 41747.4 42262.4 43626.3 43865.3 43272.4 44675.8 44716.8 44750.1 44757.8 35332.6 37361.8 37462.8 37945.8 38297.0 29103.3 29504.3 29515.0 29583.7 29765.6 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | [#2] jquery.html Cycles:180 Average:28784.14 Median:2816.55 stddev:81917.19 (2908.4%) stddev-sans-first:82119.18 20:28:47 INFO - PROCESS | 27924 | Values: 356.5 375.8 380.2 386.2 402.8 14527.9 18883.7 19403.2 19988.5 20194.8 18541.6 19659.8 19770.6 19812.6 20292.8 5511.7 5746.8 5758.1 5766.4 5779.5 5499.4 5626.0 5685.8 5705.2 5711.8 5614.0 5673.1 5685.0 5693.1 5695.7 5504.6 5572.6 5597.1 5597.5 5609.7 4970.7 4973.7 4980.6 4982.9 4991.0 23932.6 23986.2 24016.4 24024.5 24128.9 2345.9 2433.3 2518.0 2594.3 3038.8 14476.0 14916.3 15032.2 15077.5 15178.3 1895.4 1971.9 1972.4 1978.2 2008.5 52893.5 57689.7 79159.2 79394.6 80780.6 9635.8 9718.0 9928.6 10491.2 11049.8 14528.9 14595.3 14608.0 14639.9 14652.6 7876.7 7985.8 8086.4 8310.0 8312.4 7625.7 7785.6 7822.9 7838.4 8004.9 6269.9 6379.3 6463.5 6543.5 6579.8 1794.7 1810.9 1816.6 1844.5 1857.9 926.6 1053.8 1058.2 1064.5 1069.7 20155.4 20685.3 20741.2 20816.6 21061.1 992.1 1045.5 1051.2 1064.5 1086.2 11056.5 11543.3 11729.8 11896.8 11922.5 485596.0 491064.0 502857.0 506130.0 511743.0 81354.6 81430.0 82898.0 82945.0 83325.0 990.2 998.0 1015.1 1015.5 1017.1 17713.5 17909.3 18108.8 18582.5 18879.2 40966.6 40984.4 41523.6 41712.4 42030.2 53793.7 53799.7 54618.0 55389.4 56400.7 8178.8 8286.4 8360.5 8487.1 8549.9 12998.3 13136.4 13150.7 13221.3 13316.9 11332.9 11529.7 11637.1 11996.9 12352.4 11215.8 11256.7 11473.9 11646.4 11674.7 11789.4 11826.2 11961.8 11969.5 12217.8 7238.5 7587.1 7741.4 8218.1 8513.2 9077.3 11568.6 11814.2 11826.2 11972.2 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | [#3] mootools.html Cycles:180 Average:5499.10 Median:4954.04 stddev:3068.08 (61.9%) stddev-sans-first:3060.29 20:28:47 INFO - PROCESS | 27924 | Values: 1279.4 1463.3 1508.1 1642.2 1772.2 7872.0 8188.0 8203.8 8418.7 8425.4 8300.3 8389.0 8410.1 8415.1 8495.7 2104.0 2116.1 2126.4 2126.5 2136.8 2313.5 2335.1 2344.1 2346.7 2354.5 2310.1 2313.4 2318.1 2318.5 2357.3 2245.8 2299.3 2301.0 2301.1 2301.7 2236.8 2255.9 2277.6 2284.4 2290.7 8182.5 8188.3 8240.3 8248.6 8283.1 4770.1 4999.3 5001.2 5002.6 5009.2 3298.6 3362.7 3366.0 3454.1 3476.8 1076.6 1125.5 1152.4 1169.9 1180.1 11349.4 11350.3 11374.3 11428.4 11472.0 4164.3 4328.0 4329.4 4440.8 4452.4 9132.8 9136.1 9146.9 9158.3 9158.4 4937.4 4951.3 4956.8 4957.2 4960.3 4024.6 4247.2 4627.8 4631.1 4635.5 3537.7 3548.9 3645.7 3652.5 3683.5 1054.8 1089.4 1096.9 1098.2 1101.1 915.1 925.6 937.4 949.4 967.6 5588.8 5595.8 5730.7 5856.0 5857.2 956.2 985.6 997.6 1003.3 1016.4 3752.5 4010.9 4023.0 4029.3 4174.3 10024.3 10135.0 10481.4 10489.1 10492.4 10264.7 10392.5 10397.0 10424.9 10437.2 7800.3 7841.1 7905.3 7928.2 7936.0 5610.4 5691.8 5695.9 5752.7 6016.3 9149.5 9353.3 9466.2 9497.2 9605.6 9204.5 9366.9 9609.1 9664.3 9717.1 7444.1 7587.2 7591.2 7596.0 7598.8 7734.0 8034.1 8154.3 8317.8 8319.1 7183.6 7261.2 7298.9 7348.4 7436.9 7186.1 7242.1 7315.9 7380.7 7386.7 6720.3 6739.2 6751.1 6806.8 6887.6 4618.0 4643.3 4786.9 4797.6 4831.1 4926.2 4992.2 5014.5 5073.3 5264.2 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | [#4] prototype.html Cycles:180 Average:4518.26 Median:5187.85 stddev:1325.37 (25.5%) stddev-sans-first:1290.59 20:28:47 INFO - PROCESS | 27924 | Values: 293.3 311.7 317.2 319.9 331.7 5162.9 5182.1 5190.5 5205.5 5213.5 4869.4 4937.1 5018.8 5072.5 5105.9 4034.4 4034.6 4043.2 4043.3 4049.2 4037.4 4062.9 4068.8 4075.7 4088.7 3799.4 3865.2 3984.2 4015.7 4038.6 3945.1 3958.5 3965.0 3979.2 3999.6 3561.6 3564.4 3565.9 3566.0 3569.9 4742.6 4934.7 4942.4 4957.2 4977.3 4464.8 4467.6 4470.2 4485.7 4501.1 5295.8 5319.5 5324.3 5331.2 5354.3 3645.9 3778.6 3782.3 3809.0 3814.2 5489.9 5525.2 5538.2 5549.6 5602.2 3976.3 3979.3 3993.5 4001.2 4006.7 4033.4 4038.5 4060.0 4067.7 4081.1 4428.3 4496.7 4524.9 4528.2 4578.3 5263.5 5265.9 5276.1 5305.5 5341.4 1350.4 1365.9 1366.5 1366.9 1391.3 855.5 924.3 942.7 962.1 963.5 5165.6 5171.7 5185.2 5194.8 5199.0 5427.2 5447.7 5461.6 5504.2 5534.5 4982.5 5065.4 5125.8 5177.2 5183.9 2841.1 2884.3 2900.4 2907.6 2909.0 5500.6 5660.5 5711.6 5719.4 5748.2 5595.1 5602.0 5606.7 5614.5 5621.7 5661.2 5668.8 5671.7 5699.8 5747.2 5197.1 5444.0 5498.6 5539.4 5561.4 5457.4 5487.5 5489.5 5489.6 5495.5 5653.9 5695.7 5701.3 5721.5 5753.3 3866.6 3905.0 3959.4 3962.8 3967.0 5465.0 5490.3 5490.3 5514.4 5523.9 5273.7 5395.5 5423.6 5426.6 5431.4 5256.3 5307.9 5351.4 5360.9 5365.2 5120.7 5209.7 5347.7 5350.0 5362.8 5368.7 5393.6 5421.0 5430.3 5438.9 5282.8 5304.7 5306.8 5311.5 5330.4 20:28:47 INFO - PROCESS | 27924 | 20:28:47 INFO - PROCESS | 27924 | [#5] yui.html Cycles:180 Average:20391.01 Median:4526.44 stddev:28119.40 (621.2%) stddev-sans-first:28159.59 20:28:47 INFO - PROCESS | 27924 | Values: 744.4 767.3 776.1 811.3 843.3 13564.3 15256.2 15295.3 15314.0 15385.8 15484.7 15636.1 15649.5 15654.8 15659.1 642.3 669.4 670.6 673.4 784.0 809.3 818.2 820.3 825.4 827.1 872.3 873.5 874.6 874.9 875.0 674.3 870.0 872.5 875.3 875.5 614.7 634.5 637.1 638.8 639.8 14820.8 14847.9 14850.5 14858.4 14887.5 14203.5 14597.3 14989.6 15276.1 15282.4 13597.9 13618.7 13836.7 14053.0 14256.0 4286.4 4339.3 4493.7 4559.2 4573.5 77948.6 79330.0 79611.0 79789.2 80370.0 11595.8 11636.6 11688.6 11945.2 12109.7 22305.7 22378.4 22381.0 22382.8 22396.6 8236.9 8710.1 8809.0 8976.7 9075.8 4720.4 4863.4 4963.5 5137.2 5205.7 3280.5 3656.7 3800.7 3811.2 3861.8 614.1 617.6 618.8 641.0 651.7 640.8 674.7 679.1 749.1 754.6 10317.6 10344.0 10815.5 10837.2 10856.5 623.2 642.3 707.5 757.8 772.2 4833.4 5008.8 5043.2 5045.9 5193.5 72078.6 82599.4 83971.0 129310.0 130185.3 85290.6 85609.0 86832.0 105210.5 109833.4 54116.2 55939.2 77499.6 83264.6 86493.6 9955.8 10208.5 10422.1 10640.4 11028.0 48496.5 49897.8 50508.0 51059.7 52676.5 72126.3 77769.6 78038.9 79148.0 79655.0 13125.6 13385.7 13501.4 13764.1 13991.3 15322.7 15542.4 16162.0 16662.8 16868.0 13939.2 14092.4 15595.2 15607.0 15777.1 13984.7 14799.0 15362.0 15688.9 15702.8 14031.2 14179.6 14994.4 15321.3 15433.4 11363.0 11421.0 11511.7 11820.2 12264.8 11708.3 11801.3 11940.8 12007.5 12112.6 20:28:47 INFO - PROCESS | 27924 | -------- Summary: end -------- 20:28:47 INFO - PROCESS | 27924 | 20:28:48 INFO - TEST-INFO | 27924: exit 0 20:28:48 INFO - TEST-OK | dromaeo_css | took 1114511ms 20:28:48 INFO - TEST-START | kraken 20:28:48 INFO - operating with platform_type : linux_ 20:28:48 INFO - Initialising browser for kraken test... 20:28:48 INFO - TEST-INFO | started process 28234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeIMTQp/profile http://localhost:55267/getInfo.html) 20:28:51 INFO - PROCESS | 28234 | __metrics Screen width/height:1600/1200 20:28:51 INFO - PROCESS | 28234 | colorDepth:24 20:28:51 INFO - PROCESS | 28234 | Browser inner width/height: 1024/697 20:28:51 INFO - PROCESS | 28234 | __metrics 20:28:52 INFO - PROCESS | 28234 | 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" 20:28:52 INFO - PROCESS | 28234 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:52 INFO - PROCESS | 28234 | console.error: PushService: 20:28:52 INFO - PROCESS | 28234 | stateChangeProcessEnqueue: Error transitioning state 20:28:52 INFO - PROCESS | 28234 | UnknownError 20:28:53 INFO - TEST-INFO | 28234: exit 0 20:28:53 INFO - Browser initialized. 20:28:53 INFO - Running cycle 1/1 for kraken test... 20:28:53 INFO - TEST-INFO | started process 28316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeIMTQp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:05 INFO - PROCESS | 28316 | RSS: Main: 155815936 20:29:05 INFO - PROCESS | 28316 | 20:29:07 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55267/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:08 INFO - PROCESS | 28316 | RSS: Main: 203386880 20:29:08 INFO - PROCESS | 28316 | 20:29:11 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55267/tests/kraken/driver.html?testName=audio-dft) 20:29:11 INFO - PROCESS | 28316 | RSS: Main: 191467520 20:29:11 INFO - PROCESS | 28316 | 20:29:14 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55267/tests/kraken/driver.html?testName=audio-fft) 20:29:15 INFO - PROCESS | 28316 | RSS: Main: 276144128 20:29:15 INFO - PROCESS | 28316 | 20:29:17 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55267/tests/kraken/driver.html?testName=audio-oscillator) 20:29:18 INFO - PROCESS | 28316 | RSS: Main: 186265600 20:29:18 INFO - PROCESS | 28316 | 20:29:20 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:21 INFO - PROCESS | 28316 | RSS: Main: 191152128 20:29:21 INFO - PROCESS | 28316 | 20:29:24 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55267/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:24 INFO - PROCESS | 28316 | RSS: Main: 227741696 20:29:24 INFO - PROCESS | 28316 | 20:29:28 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55267/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:28 INFO - PROCESS | 28316 | RSS: Main: 226058240 20:29:28 INFO - PROCESS | 28316 | 20:29:31 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55267/tests/kraken/driver.html?testName=json-parse-financial) 20:29:32 INFO - PROCESS | 28316 | RSS: Main: 226562048 20:29:32 INFO - PROCESS | 28316 | 20:29:33 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:34 INFO - PROCESS | 28316 | RSS: Main: 189190144 20:29:34 INFO - PROCESS | 28316 | 20:29:36 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:36 INFO - PROCESS | 28316 | RSS: Main: 196734976 20:29:36 INFO - PROCESS | 28316 | 20:29:38 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:39 INFO - PROCESS | 28316 | RSS: Main: 193773568 20:29:39 INFO - PROCESS | 28316 | 20:29:41 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:42 INFO - PROCESS | 28316 | RSS: Main: 188424192 20:29:42 INFO - PROCESS | 28316 | 20:29:45 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:45 INFO - PROCESS | 28316 | RSS: Main: 191467520 20:29:45 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:55267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55267/tests/kraken/driver.html?testName=ai-astar) 20:29:47 INFO - PROCESS | 28316 | RSS: Main: 242425856 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | __start_tp_report 20:29:47 INFO - PROCESS | 28316 | _x_x_mozilla_page_load 20:29:47 INFO - PROCESS | 28316 | _x_x_mozilla_page_load_details 20:29:47 INFO - PROCESS | 28316 | |i|pagename|runs| 20:29:47 INFO - PROCESS | 28316 | |0;ai-astar;106;112;112;111;109;116;113;113;114;113 20:29:47 INFO - PROCESS | 28316 | |1;audio-beat-detection;151;124;118;174;122;122;149;121;157;118 20:29:47 INFO - PROCESS | 28316 | |2;audio-dft;162;160;160;164;162;164;164;160;161;163 20:29:47 INFO - PROCESS | 28316 | |3;audio-fft;74;76;76;111;75;77;74;76;115;76 20:29:47 INFO - PROCESS | 28316 | |4;audio-oscillator;86;93;135;85;87;86;122;85;85;137 20:29:47 INFO - PROCESS | 28316 | |5;imaging-gaussian-blur;117;116;117;117;117;118;117;118;118;117 20:29:47 INFO - PROCESS | 28316 | |6;imaging-darkroom;146;147;148;146;147;146;146;146;146;146 20:29:47 INFO - PROCESS | 28316 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 20:29:47 INFO - PROCESS | 28316 | |8;json-parse-financial;52;51;53;51;52;53;59;50;53;51 20:29:47 INFO - PROCESS | 28316 | |9;json-stringify-tinderbox;63;63;63;64;63;62;63;62;63;62 20:29:47 INFO - PROCESS | 28316 | |10;stanford-crypto-aes;85;79;78;78;79;79;78;79;82;79 20:29:47 INFO - PROCESS | 28316 | |11;stanford-crypto-ccm;127;132;130;129;121;122;124;122;142;125 20:29:47 INFO - PROCESS | 28316 | |12;stanford-crypto-pbkdf2;163;163;162;163;166;161;164;159;160;160 20:29:47 INFO - PROCESS | 28316 | |13;stanford-crypto-sha256-iterative;67;64;68;64;68;64;65;63;64;66 20:29:47 INFO - PROCESS | 28316 | __end_tp_report 20:29:47 INFO - PROCESS | 28316 | __start_cc_report 20:29:47 INFO - PROCESS | 28316 | _x_x_mozilla_cycle_collect,1643 20:29:47 INFO - PROCESS | 28316 | __end_cc_report 20:29:47 INFO - PROCESS | 28316 | __startTimestamp1471490987740__endTimestamp 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | ------- Summary: start ------- 20:29:47 INFO - PROCESS | 28316 | Number of tests: 14 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.77 (2.4%) stddev-sans-first:1.94 20:29:47 INFO - PROCESS | 28316 | Values: 106.0 112.0 112.0 111.0 109.0 116.0 113.0 113.0 114.0 113.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:136.50 stddev:20.24 (14.8%) stddev-sans-first:20.68 20:29:47 INFO - PROCESS | 28316 | Values: 151.0 124.0 118.0 174.0 122.0 122.0 149.0 121.0 157.0 118.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.70 (1.0%) stddev-sans-first:1.80 20:29:47 INFO - PROCESS | 28316 | Values: 162.0 160.0 160.0 164.0 162.0 164.0 164.0 160.0 161.0 163.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.87 (20.9%) stddev-sans-first:16.49 20:29:47 INFO - PROCESS | 28316 | Values: 74.0 76.0 76.0 111.0 75.0 77.0 74.0 76.0 115.0 76.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:85.50 stddev:22.02 (25.8%) stddev-sans-first:22.75 20:29:47 INFO - PROCESS | 28316 | Values: 86.0 93.0 135.0 85.0 87.0 86.0 122.0 85.0 85.0 137.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:29:47 INFO - PROCESS | 28316 | Values: 117.0 116.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 20:29:47 INFO - PROCESS | 28316 | Values: 146.0 147.0 148.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:29:47 INFO - PROCESS | 28316 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:2.51 (4.8%) stddev-sans-first:2.65 20:29:47 INFO - PROCESS | 28316 | Values: 52.0 51.0 53.0 51.0 52.0 53.0 59.0 50.0 53.0 51.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 20:29:47 INFO - PROCESS | 28316 | Values: 63.0 63.0 63.0 64.0 63.0 62.0 63.0 62.0 63.0 62.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.22 (2.8%) stddev-sans-first:1.22 20:29:47 INFO - PROCESS | 28316 | Values: 85.0 79.0 78.0 78.0 79.0 79.0 78.0 79.0 82.0 79.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.00 stddev:6.33 (4.9%) stddev-sans-first:6.71 20:29:47 INFO - PROCESS | 28316 | Values: 127.0 132.0 130.0 129.0 121.0 122.0 124.0 122.0 142.0 125.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.00 stddev:2.13 (1.3%) stddev-sans-first:2.24 20:29:47 INFO - PROCESS | 28316 | Values: 163.0 163.0 162.0 163.0 166.0 161.0 164.0 159.0 160.0 160.0 20:29:47 INFO - PROCESS | 28316 | 20:29:47 INFO - PROCESS | 28316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.83 (2.8%) stddev-sans-first:1.83 20:29:47 INFO - PROCESS | 28316 | Values: 67.0 64.0 68.0 64.0 68.0 64.0 65.0 63.0 64.0 66.0 20:29:47 INFO - PROCESS | 28316 | -------- Summary: end -------- 20:29:47 INFO - PROCESS | 28316 | 20:29:48 INFO - TEST-INFO | 28316: exit 0 20:29:48 INFO - TEST-OK | kraken | took 60539ms 20:29:48 INFO - SUITE-END | took 1175s 20:29:48 INFO - Completed test suite (00:19:35) 20:29:48 INFO - javascript benchmark 20:29:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2969.8515074246284, 2985.865636046378, 3009.428208640358, 3021.7280444759967, 3027.1675289295454, 5140.0, 5176.844694659157, 5204.167333226685, 5230.529252367286, 5248.737563121843, 5203.453637368069, 5221.556167725748, 5260.92108618371, 5282.973585132078, 5316.282301889244, 4759.90480190396, 4793.712377257376, 4796.400449943757, 4798.184308667535, 4950.034743225073, 4865.440474345442, 4891.192953162724, 4895.755212239392, 4919.606431485473, 4941.678790878599, 4699.295105734133, 4731.077439899221, 4762.857114286577, 4763.166445871959, 4765.09463201994, 4740.928886066712, 4770.260609605517, 4770.284457331393, 4779.522047795227, 4795.736234507101, 4726.409198850144, 4756.215224487955, 4782.282657601353, 4860.198067318888, 4866.975665121687, 5086.694798312114, 5302.92045619316, 5320.707361095138, 5354.785808567653, 5356.035913535562, 5520.1443776214755, 5565.916511252334, 5582.86042848928, 5623.381428042912, 5670.347909990322, 5587.273654424939, 5632.155176723483, 5652.3217213934595, 5706.629069110536, 5716.514096301819, 5159.1229490986625, 5172.0, 5289.338832645958, 5319.414864364917, 5346.866328341784, 5660.8867822643315, 5678.801241956512, 5712.143178523254, 5716.714164291769, 5763.991301522216, 5536.114221724585, 5548.944510554843, 5551.639143455663, 5560.638558493685, 5567.860803479945, 5459.69971651555, 5503.834884953458, 5591.776328946878, 5600.075987462104, 5637.830865074055, 5533.916991245134, 5571.13647384656, 5572.498475137257, 5622.803201887914, 5632.887342253214, 5540.833774986757, 5560.0, 5569.498745112959, 5574.60977731563, 5574.60977731563, 4190.392393102983, 4199.076203235283, 4317.093410383792, 4324.978375108167, 4331.7834108294455, 3809.5999920008, 3822.4266360046217, 3854.71089668276, 3864.6328598783634, 3932.9016774580864, 5266.1574148136115, 5293.550048245866, 5297.099493086184, 5331.86670333237, 5345.679259244458, 5469.097598896137, 5556.527695145877, 5565.193047008162, 5586.664800112007, 5597.524210442158, 5181.119209734279, 5195.844124676266, 5216.374035115735, 5280.867978300574, 5294.047071527162, 4811.807527698853, 4816.686915350491, 4820.9517904820505, 4840.346553215341, 4856.1016212000895, 5573.693446860299, 5829.825105246934, 5829.912551311733, 5833.562482813806, 5854.121881717776, 5554.50009499147, 5586.636868603528, 5589.608727389043, 5628.943710563006, 5702.657840529581, 5827.329857066492, 5835.824925252249, 5837.241158649348, 5840.503557197686, 5842.853928651818, 5255.973720131375, 5517.44825517445, 5537.750801213874, 5537.889242215214, 5543.1408131739645, 5436.619436639556, 5446.319210098738, 5449.455054494519, 5586.245856809279, 5628.0, 5408.648437851527, 5426.8371948841595, 5430.40265570779, 5462.781488740406, 5469.644473109235, 5334.0, 5340.198970154508, 5355.946440535545, 5371.328583927009, 5385.8922821542565, 5330.360356757214, 5380.946190538201, 5436.293281873489, 5463.235147079492, 5472.179173124063, 5497.065498865282, 5508.338999320107, 5523.1991361253195, 5548.195511650869, 5554.666719996813, 5274.551663108678, 5383.650062745909, 5398.217258497417, 5398.325209348832, 5403.7838486460105], "value": 5162.156060808962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.8909429191611, 570.3725901508342, 573.6156774960776, 576.700115939711, 603.7041849493746, 32873.34253314932, 43286.0, 43840.3423948641, 44008.77995610022, 44047.0, 46525.53474465254, 46973.29540056902, 47011.294830577484, 47333.0, 47375.76312118435, 8916.777080572989, 9061.728148155566, 9076.273898088137, 9087.454752714859, 9091.772705682344, 8832.646694132227, 8954.552272386387, 8986.86519702205, 8989.41568798026, 8992.77518062047, 9016.909830901706, 9052.230560402373, 9076.682316118937, 9077.95461022694, 9079.455232686027, 8983.146601072887, 9037.909620903805, 9059.048799875984, 9060.909390906072, 9066.320025998044, 8902.73291801247, 8971.955140224323, 8976.910230897673, 8982.10178982103, 8984.146506081977, 42986.0, 43765.78117109394, 43771.0, 43864.561354386366, 43908.0, 3548.822558872046, 3768.340540405418, 3781.7920014399197, 4012.859549915739, 4034.7780872052026, 32058.679413206035, 32440.837795811105, 33434.83282583596, 33780.49329260038, 34532.309353813034, 4309.892252693708, 4403.119376124756, 4409.5149533551285, 4585.060062687141, 4672.486026537078, 336868.0, 338402.0, 339611.30194349115, 339651.0, 342557.0, 58015.709921450965, 58244.0, 58250.41749582535, 58698.70650646719, 58719.706401467716, 61844.690776546726, 61866.38133618606, 61897.0, 61915.38084619186, 61988.380116199165, 16346.264418100976, 16570.502884913472, 16591.41930032443, 16595.585110372336, 16624.584385390463, 12221.69445763863, 12231.449584768707, 12235.449404776806, 12255.571055013032, 12256.938715306367, 17044.403445879336, 17214.569635759206, 17293.56766080833, 17373.0, 17440.12799360027, 6138.539609529304, 6359.682015899187, 6387.233531976192, 6447.226332839996, 6473.158489396348, 947.9571523367155, 978.951052447389, 995.144176008632, 995.3132338686428, 1047.7171163785736, 31294.56884325766, 31379.68620313813, 31850.362992740014, 31899.84050079781, 32372.0, 1051.7107795356185, 1082.2153938394758, 1124.662601219631, 1157.3287493253893, 1208.915375923677, 16176.595585110466, 16726.581835453966, 16752.162391880356, 16762.74855877163, 17334.47996560105, 525397.0, 531221.0, 531474.0, 531706.0, 531924.0, 61088.0, 61214.69392653008, 61215.69392153011, 61323.0, 61835.0, 1217.7929751942013, 1327.8141060251573, 1335.833020872391, 1361.4282001559368, 1365.044468871774, 29994.501374656335, 35345.0, 35587.82206089057, 35673.28653426865, 35775.64224357827, 53345.733271333396, 54228.0, 54268.64328391664, 54293.185602216785, 54331.45668543264, 500521.0, 506804.0, 506948.0, 507754.0, 509922.0, 44920.77539612412, 45289.773551132035, 46593.0, 46741.76629116833, 46798.76600616975, 49344.259836101766, 49797.50202497929, 50321.49678503168, 50428.243576347115, 50544.747276263384, 40976.590234097275, 41377.793111034254, 41708.0, 42828.357574637026, 43201.13597727965, 41690.79154604208, 41747.37378939258, 42262.366064509675, 43626.34560481532, 43865.34201986909, 43272.35091473693, 44675.77662111669, 44716.77641611771, 44750.10499790051, 44757.77621111873, 35332.64667353294, 37361.81319093496, 37462.8126859364, 37945.81027094847, 38297.0, 29103.272418188866, 29504.262393440335, 29515.0, 29583.704162958096, 29765.553516696833], "value": 20666.223880082875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5097990263388, 375.81021584100034, 380.1996796742856, 386.2140543992974, 402.832824377883, 14527.854721452795, 18883.716744248846, 19403.223871045142, 19988.500287492785, 20194.798052019512, 18541.629167416642, 19659.803401965975, 19770.604587908234, 19812.603747925034, 20292.797072029276, 5511.696856672881, 5746.770129194827, 5758.107493338518, 5766.394528574502, 5779.450952159538, 5499.395066542677, 5625.971870140644, 5685.829425117253, 5705.2012718219485, 5711.828645140632, 5614.0, 5673.092305231164, 5685.0, 5693.060644993571, 5695.743691533891, 5504.6421982571, 5572.58205634579, 5597.104463285896, 5597.468240517144, 5609.691466969315, 4970.676906001098, 4973.651844370896, 4980.551750342486, 4982.850514484535, 4991.0, 23932.641010384858, 23986.160484382963, 24016.399590010216, 24024.519509609883, 24128.879355603287, 2345.906163753448, 2433.270018994295, 2517.992802878845, 2594.299539124426, 3038.8024778389554, 14476.0, 14916.254187290591, 15032.248387580687, 15077.47228846996, 15178.31697573612, 1895.4029480713532, 1971.9112639931238, 1972.4477146398888, 1978.169168949045, 2008.4878356019267, 52893.47106528924, 57689.71155144197, 79159.20840791633, 79394.60302698449, 80780.59609701914, 9635.807283854283, 9717.951410243046, 9928.602855885829, 10491.16070714341, 11049.834252486218, 14528.927355363156, 14595.343209555384, 14608.0, 14639.92680036593, 14652.560423187322, 7876.684932602631, 7985.840283194304, 8086.393520485987, 8310.0, 8312.376571757142, 7625.733099341496, 7785.610719464004, 7822.882656760153, 7838.412119091091, 8004.919950800534, 6269.905951410732, 6379.266384365857, 6463.545702216964, 6543.476521878239, 6579.80260592183, 1794.7487351770762, 1810.8722251354607, 1816.609428972777, 1844.4743248174207, 1857.944261672152, 926.6293482607011, 1053.7787064716495, 1058.1534772182224, 1064.4624464645306, 1069.7432616172064, 20155.39533813988, 20685.33906849916, 20741.170353186004, 20816.583668326548, 21061.052252648362, 992.1417973452911, 1045.4877110216091, 1051.2273478992934, 1064.535600085799, 1086.2342048855537, 11056.502457389437, 11543.307401555934, 11729.765404692029, 11896.821547676791, 11922.523099076114, 485596.0, 491064.0, 502857.0, 506130.0, 511743.0, 81354.59322703349, 81430.0, 82898.0, 82945.0, 83325.0, 990.1583653894132, 997.9720887485901, 1015.0610685116238, 1015.4973288222377, 1017.1354348803605, 17713.468595942144, 17909.283628654706, 18108.818911810715, 18582.535436614195, 18879.244830207186, 40966.590334096276, 40984.38523422211, 41523.58476415197, 41712.3743143847, 42030.1593968125, 53793.73103134459, 53799.73100134474, 54617.99202087847, 55389.44610553843, 56400.71799640975, 8178.754637360888, 8286.378521611025, 8360.498370097814, 8487.108853570286, 8549.879294057748, 12998.285094319524, 13136.408861601441, 13150.671233219246, 13221.338933053501, 13316.933415332862, 11332.943335283271, 11529.711757205801, 11637.069034477052, 11996.920277175097, 12352.3823808811, 11215.775684486427, 11256.662300131009, 11473.885261147281, 11646.359450230319, 11674.70813229676, 11789.351585662871, 11826.172167948162, 11961.820572691591, 11969.521219151136, 12217.755644887231, 7238.457115716447, 7587.127480339611, 7741.380689544935, 8218.137095604876, 8513.233808957224, 9077.31920106008, 11568.595099171489, 11814.232074915102, 11826.231294965799, 11972.221805582609], "value": 9289.706327503407, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.3858947705107, 1463.2903042024616, 1508.0951429142515, 1642.203531287326, 1772.1759381887412, 7871.9606401967985, 8187.959060204698, 8203.835923281538, 8418.66325346987, 8425.410221284512, 8300.335973122152, 8389.035260944993, 8410.074891761902, 8415.116412776662, 8495.660173593064, 2104.042660589428, 2116.100657220679, 2126.4258650164447, 2126.479012641897, 2136.7970042845905, 2313.4563377606332, 2335.1243283768586, 2344.0623750499767, 2346.730126035502, 2354.505553833697, 2310.1336998625516, 2313.421644588853, 2318.107528601492, 2318.547883162784, 2357.2574638988663, 2245.831562632809, 2299.298713892262, 2300.9654855177187, 2301.091069027733, 2301.735300440454, 2236.7763223677503, 2255.853369530975, 2277.578647950118, 2284.4060544258446, 2290.7365652949793, 8182.509049457051, 8188.344932405394, 8240.258376746062, 8248.628811703487, 8283.08886022537, 4770.0698363819065, 4999.3000979862845, 5001.199808030734, 5002.574781143607, 5009.198528235502, 3298.6041674998914, 3362.7309815214726, 3365.9831700841582, 3454.0501362125365, 3476.8435420406145, 1076.580133747839, 1125.5272785430138, 1152.3661985907802, 1169.8713141554422, 1180.1208099965495, 11349.432528373549, 11350.318980861175, 11374.260673056307, 11428.428578571122, 11472.0, 4164.333706606928, 4327.956720432755, 4329.437173167468, 4440.777961101997, 4452.354408610733, 9132.817343653223, 9136.132067453582, 9146.90853091474, 9158.267338613028, 9158.40470369424, 4937.432195297515, 4951.257311403247, 4956.826511072168, 4957.157283261854, 4960.280759289883, 4024.557298697141, 4247.17180149874, 4627.791749371287, 4631.0506346198945, 4635.513271106553, 3537.7346698997676, 3548.946765798515, 3645.744797864177, 3652.4521321801944, 3683.465897444909, 1054.7679510507676, 1089.4443833644898, 1096.9177311701494, 1098.1653943003375, 1101.1191047162238, 915.0757734688013, 925.5973651461636, 937.3727744844024, 949.368669834566, 967.56943160293, 5588.832335029955, 5595.804146854841, 5730.713464326767, 5855.970720146372, 5857.179994800731, 956.1776871890169, 985.6106837799173, 997.6458357283205, 1003.2726273451689, 1016.3546148195949, 3752.4614907887635, 4010.939835902464, 4022.9798851005557, 4029.2545879012478, 4174.286713636161, 10024.298299118991, 10135.0, 10481.423521706227, 10489.108425783894, 10492.370457772558, 10264.743381415525, 10392.532336044897, 10397.0, 10424.895751042544, 10437.165026797838, 7800.297973182441, 7841.137474877759, 7905.288524032865, 7928.167542407964, 7936.007999000125, 5610.438956104357, 5691.8292451226525, 5695.943040569541, 5752.712364381848, 6016.2780466342565, 9149.451032938045, 9353.25173986093, 9466.195373393339, 9497.24022078246, 9605.615775368908, 9204.493752843659, 9366.859497107685, 9609.087136722, 9664.323497355117, 9717.125458708468, 7444.143923448656, 7587.165411804807, 7591.202923693154, 7595.962020190084, 7598.784194528849, 7733.961330193313, 8034.116247212919, 8154.347652187692, 8317.792055198668, 8319.126491718282, 7183.640817959185, 7261.164966028974, 7298.854022919618, 7348.375388091858, 7436.851262974602, 7186.065811444479, 7242.058532390755, 7315.853682926205, 7380.667869945973, 7386.704531818667, 6720.294369091175, 6739.157605299338, 6751.122354094133, 6806.829829254309, 6887.621180835102, 4617.953820461887, 4643.257078867365, 4786.904261914812, 4797.616190704665, 4831.06634413296, 4926.187179115406, 4992.226204938241, 5014.473480284663, 5073.315102461268, 5264.184051472028], "value": 4434.543452837241, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2756092451645, 311.67430035612784, 317.16743548186014, 319.8752486530253, 331.6716450713793, 5162.896742065156, 5182.144946083901, 5190.506901844319, 5205.453427390126, 5213.478652134785, 4869.391326084239, 4937.136001199785, 5018.774155163017, 5072.51811077947, 5105.897882042357, 4034.3746719258415, 4034.5965403459713, 4043.231785960673, 4043.312636851735, 4049.1699201663587, 4037.4347591337237, 4062.8715888765632, 4068.820042187762, 4075.673946084306, 4088.6524645405175, 3799.3920972644382, 3865.246276975977, 3984.163325701606, 4015.7389769665024, 4038.5759495253014, 3945.053187235057, 3958.4656071430563, 3964.960350396488, 3979.214549815112, 3999.580044095357, 3561.6082230954576, 3564.3940530109944, 3565.94651080234, 3566.0, 3569.94645080324, 4742.644301677354, 4934.654574179773, 4942.406911170647, 4957.231629097496, 4977.278294647292, 4464.754438505881, 4467.597916187558, 4470.173017991682, 4485.699147247295, 4501.144782491317, 5295.814646487393, 5319.521243088102, 5324.254604355393, 5331.173668081454, 5354.303940487751, 3645.9270814583824, 3778.6410291022307, 3782.3002744492355, 3808.980955095207, 3814.179951310454, 5489.890202195934, 5525.198846167324, 5538.224648549206, 5549.639273447254, 5602.215689803431, 3976.304146774303, 3979.323515002399, 3993.4608827808456, 4001.239764444746, 4006.6994975376965, 4033.415154802537, 4038.5355684096703, 4059.9797001014804, 4067.7355971861734, 4081.10215752534, 4428.269335559661, 4496.685232033792, 4524.886877828015, 4528.166092732448, 4578.267477203632, 5263.526282634504, 5265.921011184835, 5276.07178016197, 5305.469453054741, 5341.385740639798, 1350.3990724127668, 1365.863413658626, 1366.5285476510587, 1366.9453221871213, 1391.304347826087, 855.4696088425092, 924.3021518753299, 942.7124726958207, 962.100436092256, 963.494165563071, 5165.638405311592, 5171.707073231692, 5185.196294574347, 5194.792208311701, 5199.0, 5427.158790387496, 5447.700376479253, 5461.590380721462, 5504.2294078829, 5534.52956498694, 4982.4768399317545, 5065.442801291855, 5125.769340379692, 5177.171652535651, 5183.922241166386, 2841.0624493916957, 2884.293348129722, 2900.4489147062413, 2907.5752881088115, 2909.0, 5500.58745594074, 5660.4622111180515, 5711.628744131618, 5719.428057194247, 5748.166515855261, 5595.125632912938, 5602.0, 5606.747696353674, 5614.522765564972, 5621.662700237999, 5661.179129026268, 5668.829935101953, 5671.695510032716, 5699.82900512977, 5747.166660834239, 5197.064528384927, 5443.972780136074, 5498.5876059294915, 5539.362973258127, 5561.416051314553, 5457.399686034612, 5487.506124448819, 5489.490390142742, 5489.560835133259, 5495.477929596682, 5653.915191272216, 5695.73265494007, 5701.315842098975, 5721.456461636138, 5753.338366087954, 3866.5553461352306, 3904.9609503905735, 3959.386295124145, 3962.8018599070506, 3966.960330396659, 5465.0, 5490.286262785812, 5490.313710786152, 5514.36584792754, 5523.861903452445, 5273.709945952856, 5395.4604539545735, 5423.613610011582, 5426.620136590559, 5431.402545720047, 5256.264123022704, 5307.867303317294, 5351.357837059422, 5360.946390536044, 5365.22204280385, 5120.667156634807, 5209.661372010959, 5347.652402593819, 5349.973250133725, 5362.785488580413, 5368.651037682538, 5393.649412788156, 5421.0, 5430.294061771944, 5438.918416223681, 5282.762275697526, 5304.655197412156, 5306.8407947761625, 5311.468853114812, 5330.387005494418], "value": 4094.5788220543577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.4230721191079, 767.2902565127256, 776.1346099099505, 811.3306522119253, 843.2832092721186, 13564.253966031863, 15256.160911149882, 15295.311710973005, 15314.0, 15385.846141538595, 15484.69030619387, 15636.061836289831, 15649.45226917058, 15654.84345156548, 15659.13874736889, 642.3255581639272, 669.3674477618653, 670.6177478837064, 673.4006734006738, 783.9686412543491, 809.3161278719473, 818.1654712193559, 820.2822530285999, 825.3850881093593, 827.0943317067831, 872.2934423117264, 873.52829472085, 874.6020560644923, 874.921257086862, 875.011237301848, 674.3391476353153, 869.9782505437352, 872.5244741615835, 875.3259989807844, 875.4659657608853, 614.6895817612123, 634.4765568406037, 637.1366797988751, 638.7987783848073, 639.7792761497276, 14820.777688334683, 14847.851521484756, 14850.480233191895, 14858.405663773436, 14887.47893823711, 14203.502877399345, 14597.270136493238, 14989.550313490612, 15276.083434993936, 15282.388704451809, 13597.86402135976, 13618.727625447535, 13836.723265534632, 14053.0, 14256.0, 4286.421333120051, 4339.305711086211, 4493.707908985938, 4559.17934771741, 4573.542645735433, 77948.61025694892, 79330.0, 79611.0, 79789.20210797875, 80370.0, 11595.76808463826, 11636.592719254786, 11688.590899318484, 11945.16383853122, 12109.697257568456, 22305.665415018786, 22378.44053898633, 22381.0, 22382.776172238067, 22396.55206895853, 8236.876446853303, 8710.128987101365, 8809.0, 8976.730698079067, 9075.773105672279, 4720.386349774507, 4863.367762190964, 4963.528464795839, 5137.17805151174, 5205.6616319939085, 3280.458724310462, 3656.7257455690396, 3800.733948623625, 3811.19964807388, 3861.768293902375, 614.0942110387143, 617.6232498176109, 618.811262564922, 641.0224407778082, 651.664392837689, 640.8365866703961, 674.7348721147848, 679.0662838596929, 749.0935967479302, 754.5849782619538, 10317.587296508205, 10343.951582775084, 10815.459227038617, 10837.241393102564, 10856.457177141112, 623.1618473153601, 642.2934771751037, 707.4587940225731, 757.81812365032, 772.1660606544918, 4833.419989601271, 5008.824691135793, 5043.218301163325, 5045.924311135336, 5193.506616871391, 72078.63960680268, 82599.39204863597, 83971.0, 129310.0, 130185.34907325402, 85290.57354713311, 85609.0, 86832.0, 105210.4739476313, 109833.40999540054, 54116.18825717539, 55939.16091258635, 77499.61250193712, 83264.58367708123, 86493.56753216193, 9955.751106222402, 10208.54061567246, 10422.114120299859, 10640.361578305326, 11028.0, 48496.5150348492, 49897.75051124721, 50508.0, 51059.74470127626, 52676.473235267156, 72126.27873721195, 77769.61115194387, 78038.87844486385, 79148.0, 79655.0, 13125.60623181306, 13385.66535836573, 13501.392437340146, 13764.105333153313, 13991.300434978413, 15322.693546129238, 15542.378304867678, 16162.040300126544, 16662.83337166613, 16868.0, 13939.233342166279, 14092.436302547783, 15595.220238988231, 15607.0, 15777.132257725936, 13984.720305593628, 14799.0, 15362.0, 15688.921555392606, 15702.842971570139, 14031.228282444563, 14179.574612761633, 14994.400223990919, 15321.339330334833, 15433.382664693736, 11363.0, 11421.029212516696, 11511.712207194887, 11820.23168494045, 12264.816027759412, 11708.297502149899, 11801.29192248468, 11940.820887686517, 12007.459664314953, 12112.576059837864], "value": 7747.78932599895, "unit": "score"}], "name": "dromaeo_css", "value": 7201.064693679007, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 111.0, 109.0, 116.0, 113.0, 113.0, 114.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 118.0, 174.0, 122.0, 122.0, 149.0, 121.0, 157.0, 118.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 164.0, 162.0, 164.0, 164.0, 160.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 111.0, 75.0, 77.0, 74.0, 76.0, 115.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 93.0, 135.0, 85.0, 87.0, 86.0, 122.0, 85.0, 85.0, 137.0], "value": 100.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 51.0, 52.0, 53.0, 59.0, 50.0, 53.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 78.0, 78.0, 79.0, 79.0, 78.0, 79.0, 82.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 130.0, 129.0, 121.0, 122.0, 124.0, 122.0, 142.0, 125.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 166.0, 161.0, 164.0, 159.0, 160.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 68.0, 64.0, 68.0, 64.0, 65.0, 63.0, 64.0, 66.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1501.0, "alertThreshold": 2.0}]} 20:29:48 INFO - Return code: 0 20:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:29:49 INFO - # TBPL SUCCESS # 20:29:49 INFO - Running post-action listener: _resource_record_post_action 20:29:49 INFO - [mozharness: 2016-08-18 03:29:49.027167Z] Finished run-tests step (success) 20:29:49 INFO - Running post-run listener: _resource_record_post_run 20:29:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 422141952; Read time: 0; Write time: 279604 20:29:49 INFO - TinderboxPrint: CPU usage
12.9% 20:29:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:29:49 INFO - TinderboxPrint: I/O write bytes / time
422,141,952 / 279,604 20:29:49 INFO - TinderboxPrint: CPU idle
8,278.9 (87.0%) 20:29:49 INFO - TinderboxPrint: CPU user
1,188.7 (12.5%) 20:29:49 INFO - TinderboxPrint: Swap in / out
0 / 0 20:29:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 129462272; Read time: 0; Write time: 97640 20:29:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 292065280; Read time: 0; Write time: 181964 20:29:49 INFO - Running post-run listener: _upload_blobber_files 20:29:49 INFO - Blob upload gear active. 20:29:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:49 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 20:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:55 INFO - (blobuploader) - INFO - Done attempting. 20:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:56 INFO - (blobuploader) - INFO - Done attempting. 20:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:57 INFO - (blobuploader) - INFO - Done attempting. 20:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:57 INFO - Return code: 0 20:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2143288f513b3125ea373a893a39444a7b8c32fe6c948d1bfe84ea73c6450e25e953532dc1ea6b06a3ca0848b2cca43e1448a1f11354caa67da68880ab40e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8948ab001e47186906a81a374ea691a63d1bd616323f51d93bfcc86346a90aaabf1439d8298e6ab8073262b538f091f14943484214f140957aad66fa600ec145", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c99be0d428d17dc8f3a82a0acde0f608d8d2917b4cd0cf1623c8c102e0ff24d2db21d40cb62ce13252a21b31cb5354c2903d5ae9bfd03fd42ac22af6bda7f8a"} 20:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:57 INFO - Contents: 20:29:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2143288f513b3125ea373a893a39444a7b8c32fe6c948d1bfe84ea73c6450e25e953532dc1ea6b06a3ca0848b2cca43e1448a1f11354caa67da68880ab40e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8948ab001e47186906a81a374ea691a63d1bd616323f51d93bfcc86346a90aaabf1439d8298e6ab8073262b538f091f14943484214f140957aad66fa600ec145", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c99be0d428d17dc8f3a82a0acde0f608d8d2917b4cd0cf1623c8c102e0ff24d2db21d40cb62ce13252a21b31cb5354c2903d5ae9bfd03fd42ac22af6bda7f8a"} 20:29:57 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:57 INFO - Copying logs to upload dir... 20:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.013410 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-17 20:29:56.204713) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:56.211977) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2143288f513b3125ea373a893a39444a7b8c32fe6c948d1bfe84ea73c6450e25e953532dc1ea6b06a3ca0848b2cca43e1448a1f11354caa67da68880ab40e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8948ab001e47186906a81a374ea691a63d1bd616323f51d93bfcc86346a90aaabf1439d8298e6ab8073262b538f091f14943484214f140957aad66fa600ec145", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c99be0d428d17dc8f3a82a0acde0f608d8d2917b4cd0cf1623c8c102e0ff24d2db21d40cb62ce13252a21b31cb5354c2903d5ae9bfd03fd42ac22af6bda7f8a"} build_url:https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2143288f513b3125ea373a893a39444a7b8c32fe6c948d1bfe84ea73c6450e25e953532dc1ea6b06a3ca0848b2cca43e1448a1f11354caa67da68880ab40e0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8948ab001e47186906a81a374ea691a63d1bd616323f51d93bfcc86346a90aaabf1439d8298e6ab8073262b538f091f14943484214f140957aad66fa600ec145", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c99be0d428d17dc8f3a82a0acde0f608d8d2917b4cd0cf1623c8c102e0ff24d2db21d40cb62ce13252a21b31cb5354c2903d5ae9bfd03fd42ac22af6bda7f8a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:56.238543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:56.238893) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1471489401.987062-2068387689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:56.322450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:29:56.322818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:29:56.323109) ========= ========= Total master_lag: 0.17 =========