builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1471593411.78 results: success (0) buildid: 20160818203024 builduid: 9ee2096f9ff14e1daab42964e5bfec79 revision: 095ec4971ffb722809e2b423d27d493cf693d3f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.779809) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.780299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.780584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.801962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.802245) ========= 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=41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 00:56:51-- 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% 227M=0s 2016-08-19 00:56:51 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.896528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.896844) ========= 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=41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013661 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:51.955688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 00:56:51.956060) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 095ec4971ffb722809e2b423d27d493cf693d3f9 --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 095ec4971ffb722809e2b423d27d493cf693d3f9 --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=41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 00:56:52,013 truncating revision to first 12 chars 2016-08-19 00:56:52,013 Setting DEBUG logging. 2016-08-19 00:56:52,013 attempt 1/10 2016-08-19 00:56:52,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/095ec4971ffb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 00:56:52,958 unpacking tar archive at: fx-team-095ec4971ffb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.276908 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 00:56:53.253213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:53.253526) ========= script_repo_revision: 095ec4971ffb722809e2b423d27d493cf693d3f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:53.253949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:53.254240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 00:56:53.264186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-19 00:56:53.264536) ========= /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=41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:56:53 INFO - MultiFileLogger online at 20160819 00:56:53 in /builds/slave/test 00:56:53 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 00:56:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:56:53 INFO - {'append_to_log': False, 00:56:53 INFO - 'base_work_dir': '/builds/slave/test', 00:56:53 INFO - 'blob_upload_branch': 'Fx-Team', 00:56:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:56:53 INFO - 'branch': 'Fx-Team', 00:56:53 INFO - 'buildbot_json_path': 'buildprops.json', 00:56:53 INFO - 'config_files': ('talos/linux_config.py',), 00:56:53 INFO - 'default_actions': ('clobber', 00:56:53 INFO - 'read-buildbot-config', 00:56:53 INFO - 'download-and-extract', 00:56:53 INFO - 'populate-webroot', 00:56:53 INFO - 'create-virtualenv', 00:56:53 INFO - 'install', 00:56:53 INFO - 'run-tests'), 00:56:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:56:53 INFO - 'download_minidump_stackwalk': True, 00:56:53 INFO - 'download_symbols': 'ondemand', 00:56:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:56:53 INFO - 'tooltool.py': '/tools/tooltool.py', 00:56:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:56:53 INFO - '/tools/misc-python/virtualenv.py')}, 00:56:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:56:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:56:53 INFO - 'installer_path': 'installer.exe', 00:56:53 INFO - 'log_level': 'info', 00:56:53 INFO - 'log_name': 'talos', 00:56:53 INFO - 'log_to_console': True, 00:56:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:56:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:56:53 INFO - 'opt_config_files': (), 00:56:53 INFO - 'pip_index': False, 00:56:53 INFO - 'sps_profile': False, 00:56:53 INFO - 'sps_profile_interval': 0, 00:56:53 INFO - 'suite': 'dromaeojs', 00:56:53 INFO - 'system_bits': '32', 00:56:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:56:53 INFO - 'title': 'talos-linux64-ix-026', 00:56:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:56:53 INFO - 'use_talos_json': True, 00:56:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:56:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:56:53 INFO - 'work_dir': 'build'} 00:56:53 INFO - [mozharness: 2016-08-19 07:56:53.407086Z] Running clobber step. 00:56:53 INFO - Running pre-action listener: _resource_record_pre_action 00:56:53 INFO - Running main action method: clobber 00:56:53 INFO - rmtree: /builds/slave/test/build 00:56:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:56:53 INFO - Running post-action listener: _resource_record_post_action 00:56:53 INFO - [mozharness: 2016-08-19 07:56:53.867220Z] Finished clobber step (success) 00:56:53 INFO - [mozharness: 2016-08-19 07:56:53.867322Z] Running read-buildbot-config step. 00:56:53 INFO - Running pre-action listener: _resource_record_pre_action 00:56:53 INFO - Running main action method: read_buildbot_config 00:56:53 INFO - Using buildbot properties: 00:56:53 INFO - { 00:56:53 INFO - "project": "", 00:56:53 INFO - "product": "firefox", 00:56:53 INFO - "script_repo_revision": "production", 00:56:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:56:53 INFO - "repository": "", 00:56:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:56:53 INFO - "buildid": "20160818203024", 00:56:53 INFO - "pgo_build": "True", 00:56:53 INFO - "basedir": "/builds/slave/test", 00:56:53 INFO - "buildnumber": 994, 00:56:53 INFO - "slavename": "talos-linux64-ix-026", 00:56:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:56:53 INFO - "platform": "ubuntu64_hw", 00:56:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:56:53 INFO - "branch": "fx-team", 00:56:53 INFO - "repo_path": "integration/fx-team", 00:56:53 INFO - "revision": "095ec4971ffb722809e2b423d27d493cf693d3f9", 00:56:53 INFO - "stage_platform": "linux64-pgo", 00:56:53 INFO - "builduid": "9ee2096f9ff14e1daab42964e5bfec79", 00:56:53 INFO - "slavebuilddir": "test" 00:56:53 INFO - } 00:56:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:56:53 INFO - Running post-action listener: _resource_record_post_action 00:56:53 INFO - [mozharness: 2016-08-19 07:56:53.869727Z] Finished read-buildbot-config step (success) 00:56:53 INFO - [mozharness: 2016-08-19 07:56:53.869814Z] Running download-and-extract step. 00:56:53 INFO - Running pre-action listener: _resource_record_pre_action 00:56:53 INFO - Running main action method: download_and_extract 00:56:53 INFO - mkdir: /builds/slave/test/build/tests 00:56:53 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')]} 00:56:53 INFO - trying https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:56:53 INFO - Downloading https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:56:54 INFO - Downloaded 1361 bytes. 00:56:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:56:54 INFO - Using the following test package requirements: 00:56:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:56:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:56:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'jsshell-linux-x86_64.zip'], 00:56:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:56:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:56:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:56:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:56:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:56:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:56:54 INFO - trying https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:56:54 INFO - Downloading https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:56:55 INFO - Downloaded 21906549 bytes. 00:56:55 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 00:56:59 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 00:56:59 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')]} 00:56:59 INFO - trying https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:56:59 INFO - Downloading https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:57:01 INFO - Downloaded 21906549 bytes. 00:57:01 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 00:57:05 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')]} 00:57:05 INFO - trying https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:57:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:57:07 INFO - Downloaded 14413981 bytes. 00:57:07 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 00:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:07 INFO - trying https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:57:07 INFO - Downloading https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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 00:57:10 INFO - Downloaded 59585386 bytes. 00:57:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:57:10 INFO - mkdir: /builds/slave/test/properties 00:57:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:57:10 INFO - Writing to file /builds/slave/test/properties/build_url 00:57:10 INFO - Contents: 00:57:10 INFO - build_url:https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:57:10 INFO - Running post-action listener: _resource_record_post_action 00:57:10 INFO - Running post-action listener: set_extra_try_arguments 00:57:10 INFO - [mozharness: 2016-08-19 07:57:10.968286Z] Finished download-and-extract step (success) 00:57:10 INFO - [mozharness: 2016-08-19 07:57:10.968509Z] Running populate-webroot step. 00:57:10 INFO - Running pre-action listener: _resource_record_pre_action 00:57:10 INFO - Running main action method: populate_webroot 00:57:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:57:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:57:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:57:10 INFO - '--tppagecycles', 00:57:10 INFO - '7'], 00:57:10 INFO - 'tests': ['tsvgm']}}, 00:57:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:57:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:57:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:57:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:57:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:57:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:57:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['damp', 'tps']}, 00:57:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'tests': ['damp', 'tps']}, 00:57:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['dromaeo_dom']}, 00:57:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:57:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['basic_compositor_video']}, 00:57:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:57:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['a11yr', 00:57:10 INFO - 'ts_paint', 00:57:10 INFO - 'tpaint', 00:57:10 INFO - 'sessionrestore', 00:57:10 INFO - 'sessionrestore_no_auto_restore', 00:57:10 INFO - 'tabpaint']}, 00:57:10 INFO - 'other-e10s': {'tests': ['a11yr', 00:57:10 INFO - 'ts_paint', 00:57:10 INFO - 'tpaint', 00:57:10 INFO - 'sessionrestore', 00:57:10 INFO - 'sessionrestore_no_auto_restore', 00:57:10 INFO - 'tabpaint']}, 00:57:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:57:10 INFO - 'ts_paint', 00:57:10 INFO - 'tpaint', 00:57:10 INFO - 'sessionrestore', 00:57:10 INFO - 'sessionrestore_no_auto_restore', 00:57:10 INFO - 'tabpaint']}, 00:57:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:57:10 INFO - 'ts_paint', 00:57:10 INFO - 'tpaint', 00:57:10 INFO - 'sessionrestore', 00:57:10 INFO - 'sessionrestore_no_auto_restore', 00:57:10 INFO - 'tabpaint']}, 00:57:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['a11yr', 00:57:10 INFO - 'ts_paint', 00:57:10 INFO - 'tpaint', 00:57:10 INFO - 'sessionrestore', 00:57:10 INFO - 'sessionrestore_no_auto_restore', 00:57:10 INFO - 'tabpaint']}, 00:57:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['a11yr', 00:57:10 INFO - 'ts_paint', 00:57:10 INFO - 'tpaint', 00:57:10 INFO - 'sessionrestore', 00:57:10 INFO - 'sessionrestore_no_auto_restore', 00:57:10 INFO - 'tabpaint']}, 00:57:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['tsvgx', 00:57:10 INFO - 'tsvgr_opacity', 00:57:10 INFO - 'tart', 00:57:10 INFO - 'tscrollx', 00:57:10 INFO - 'cart']}, 00:57:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:57:10 INFO - 'tsvgr_opacity', 00:57:10 INFO - 'tart', 00:57:10 INFO - 'tscrollx', 00:57:10 INFO - 'cart']}, 00:57:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'talos_options': ['--disable-e10s'], 00:57:10 INFO - 'tests': ['tp5o']}, 00:57:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'tests': ['tp5o']}, 00:57:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'talos_options': ['--disable-e10s', 00:57:10 INFO - '--xperf_path', 00:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:57:10 INFO - 'tests': ['tp5n']}, 00:57:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:10 INFO - 'talos_options': ['--xperf_path', 00:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:57:10 INFO - 'tests': ['tp5n']}}, 00:57:10 INFO - 'talos.zip': {'path': '', 00:57:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:57:10 INFO - Running post-action listener: _resource_record_post_action 00:57:10 INFO - [mozharness: 2016-08-19 07:57:10.992134Z] Finished populate-webroot step (success) 00:57:10 INFO - [mozharness: 2016-08-19 07:57:10.992221Z] Running create-virtualenv step. 00:57:10 INFO - Running pre-action listener: _resource_record_pre_action 00:57:10 INFO - Running main action method: create_virtualenv 00:57:10 INFO - Creating virtualenv /builds/slave/test/build/venv 00:57:10 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 00:57:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:57:11 INFO - Using real prefix '/usr' 00:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:57:11 INFO - Installing distribute.............................................................................................................................................................................................done. 00:57:13 INFO - Installing pip.................done. 00:57:13 INFO - Return code: 0 00:57:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:57: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')]} 00:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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')]} 00:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:57:13 INFO - Using env: {'DISPLAY': ':0', 00:57:13 INFO - 'HOME': '/home/cltbld', 00:57:13 INFO - 'LANG': 'en_US.UTF-8', 00:57:13 INFO - 'LANGUAGE': 'en_US:en', 00:57:13 INFO - 'LOGNAME': 'cltbld', 00:57:13 INFO - 'MAIL': '/var/mail/cltbld', 00:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:13 INFO - 'MOZ_NO_REMOTE': '1', 00:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:13 INFO - 'NO_EM_RESTART': '1', 00:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:13 INFO - 'PWD': '/builds/slave/test', 00:57:13 INFO - 'SHELL': '/bin/bash', 00:57:13 INFO - 'SHLVL': '1', 00:57:13 INFO - 'TERM': 'linux', 00:57:13 INFO - 'TMOUT': '86400', 00:57:13 INFO - 'USER': 'cltbld', 00:57:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:13 INFO - '_': '/tools/buildbot/bin/python'} 00:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:13 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 00:57:13 INFO - Cleaning up... 00:57:13 INFO - Return code: 0 00:57:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:57: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')]} 00:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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')]} 00:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:57:13 INFO - Using env: {'DISPLAY': ':0', 00:57:13 INFO - 'HOME': '/home/cltbld', 00:57:13 INFO - 'LANG': 'en_US.UTF-8', 00:57:13 INFO - 'LANGUAGE': 'en_US:en', 00:57:13 INFO - 'LOGNAME': 'cltbld', 00:57:13 INFO - 'MAIL': '/var/mail/cltbld', 00:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:13 INFO - 'MOZ_NO_REMOTE': '1', 00:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:13 INFO - 'NO_EM_RESTART': '1', 00:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:13 INFO - 'PWD': '/builds/slave/test', 00:57:13 INFO - 'SHELL': '/bin/bash', 00:57:13 INFO - 'SHLVL': '1', 00:57:13 INFO - 'TERM': 'linux', 00:57:13 INFO - 'TMOUT': '86400', 00:57:13 INFO - 'USER': 'cltbld', 00:57:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:13 INFO - '_': '/tools/buildbot/bin/python'} 00:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:13 INFO - Downloading/unpacking psutil>=3.1.1 00:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:57:15 INFO - Installing collected packages: psutil 00:57:15 INFO - Running setup.py install for psutil 00:57:16 INFO - building 'psutil._psutil_linux' extension 00:57:16 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 00:57:16 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 00:57:16 INFO - building 'psutil._psutil_posix' extension 00:57:16 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 00:57:16 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 00:57:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:57:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:57:16 INFO - Successfully installed psutil 00:57:16 INFO - Cleaning up... 00:57:16 INFO - Return code: 0 00:57:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:16 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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:16 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 00:57:16 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 00:57:16 INFO - Using env: {'DISPLAY': ':0', 00:57:16 INFO - 'HOME': '/home/cltbld', 00:57:16 INFO - 'LANG': 'en_US.UTF-8', 00:57:16 INFO - 'LANGUAGE': 'en_US:en', 00:57:16 INFO - 'LOGNAME': 'cltbld', 00:57:16 INFO - 'MAIL': '/var/mail/cltbld', 00:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:16 INFO - 'MOZ_NO_REMOTE': '1', 00:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:16 INFO - 'NO_EM_RESTART': '1', 00:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:16 INFO - 'PWD': '/builds/slave/test', 00:57:16 INFO - 'SHELL': '/bin/bash', 00:57:16 INFO - 'SHLVL': '1', 00:57:16 INFO - 'TERM': 'linux', 00:57:16 INFO - 'TMOUT': '86400', 00:57:16 INFO - 'USER': 'cltbld', 00:57:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:16 INFO - '_': '/tools/buildbot/bin/python'} 00:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:57:16 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 00:57:16 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 00:57:16 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 00:57:16 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 00:57:16 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 00:57:16 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 00:57:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:57:18 INFO - Installing collected packages: mozsystemmonitor 00:57:18 INFO - Running setup.py install for mozsystemmonitor 00:57:18 INFO - Successfully installed mozsystemmonitor 00:57:18 INFO - Cleaning up... 00:57:18 INFO - Return code: 0 00:57:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:18 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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:18 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 00:57:18 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 00:57:18 INFO - Using env: {'DISPLAY': ':0', 00:57:18 INFO - 'HOME': '/home/cltbld', 00:57:18 INFO - 'LANG': 'en_US.UTF-8', 00:57:18 INFO - 'LANGUAGE': 'en_US:en', 00:57:18 INFO - 'LOGNAME': 'cltbld', 00:57:18 INFO - 'MAIL': '/var/mail/cltbld', 00:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:18 INFO - 'MOZ_NO_REMOTE': '1', 00:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:18 INFO - 'NO_EM_RESTART': '1', 00:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:18 INFO - 'PWD': '/builds/slave/test', 00:57:18 INFO - 'SHELL': '/bin/bash', 00:57:18 INFO - 'SHLVL': '1', 00:57:18 INFO - 'TERM': 'linux', 00:57:18 INFO - 'TMOUT': '86400', 00:57:18 INFO - 'USER': 'cltbld', 00:57:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:18 INFO - '_': '/tools/buildbot/bin/python'} 00:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:18 INFO - Downloading/unpacking jsonschema==2.5.1 00:57:18 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 00:57:18 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 00:57:18 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 00:57:18 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 00:57:18 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 00:57:18 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 00:57:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:57:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:57:20 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 00:57:20 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 00:57:20 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 00:57:20 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 00:57:20 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 00:57:20 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 00:57:21 INFO - Downloading functools32-3.2.3-2.tar.gz 00:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:57:21 INFO - warning: no files found matching '*.txt' 00:57:21 INFO - no previously-included directories found matching 'build' 00:57:21 INFO - no previously-included directories found matching 'dist' 00:57:21 INFO - no previously-included directories found matching '.git*' 00:57:21 INFO - Installing collected packages: jsonschema, functools32 00:57:21 INFO - Running setup.py install for functools32 00:57:21 INFO - warning: no files found matching '*.txt' 00:57:21 INFO - no previously-included directories found matching 'build' 00:57:21 INFO - no previously-included directories found matching 'dist' 00:57:21 INFO - no previously-included directories found matching '.git*' 00:57:21 INFO - Successfully installed jsonschema functools32 00:57:21 INFO - Cleaning up... 00:57:21 INFO - Return code: 0 00:57:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:21 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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:21 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 00:57:21 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 00:57:21 INFO - Using env: {'DISPLAY': ':0', 00:57:21 INFO - 'HOME': '/home/cltbld', 00:57:21 INFO - 'LANG': 'en_US.UTF-8', 00:57:21 INFO - 'LANGUAGE': 'en_US:en', 00:57:21 INFO - 'LOGNAME': 'cltbld', 00:57:21 INFO - 'MAIL': '/var/mail/cltbld', 00:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:21 INFO - 'MOZ_NO_REMOTE': '1', 00:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:21 INFO - 'NO_EM_RESTART': '1', 00:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:21 INFO - 'PWD': '/builds/slave/test', 00:57:21 INFO - 'SHELL': '/bin/bash', 00:57:21 INFO - 'SHLVL': '1', 00:57:21 INFO - 'TERM': 'linux', 00:57:21 INFO - 'TMOUT': '86400', 00:57:21 INFO - 'USER': 'cltbld', 00:57:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:21 INFO - '_': '/tools/buildbot/bin/python'} 00:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:57:21 INFO - Cleaning up... 00:57:21 INFO - Return code: 0 00:57:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:21 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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:21 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 00:57:21 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 00:57:21 INFO - Using env: {'DISPLAY': ':0', 00:57:21 INFO - 'HOME': '/home/cltbld', 00:57:21 INFO - 'LANG': 'en_US.UTF-8', 00:57:21 INFO - 'LANGUAGE': 'en_US:en', 00:57:21 INFO - 'LOGNAME': 'cltbld', 00:57:21 INFO - 'MAIL': '/var/mail/cltbld', 00:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:21 INFO - 'MOZ_NO_REMOTE': '1', 00:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:21 INFO - 'NO_EM_RESTART': '1', 00:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:21 INFO - 'PWD': '/builds/slave/test', 00:57:21 INFO - 'SHELL': '/bin/bash', 00:57:21 INFO - 'SHLVL': '1', 00:57:21 INFO - 'TERM': 'linux', 00:57:21 INFO - 'TMOUT': '86400', 00:57:21 INFO - 'USER': 'cltbld', 00:57:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:21 INFO - '_': '/tools/buildbot/bin/python'} 00:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:21 INFO - Downloading/unpacking blobuploader==1.2.4 00:57:21 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 00:57:21 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 00:57:21 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 00:57:21 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 00:57:21 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 00:57:21 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 00:57:23 INFO - Downloading blobuploader-1.2.4.tar.gz 00:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:57:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:57:23 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 00:57:23 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 00:57:23 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 00:57:23 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 00:57:23 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 00:57:23 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 00:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:57:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:57:24 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 00:57:24 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 00:57:24 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 00:57:24 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 00:57:24 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 00:57:24 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 00:57:24 INFO - Downloading docopt-0.6.1.tar.gz 00:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:57:24 INFO - Installing collected packages: blobuploader, requests, docopt 00:57:24 INFO - Running setup.py install for blobuploader 00:57:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:57:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:57:24 INFO - Running setup.py install for requests 00:57:24 INFO - Running setup.py install for docopt 00:57:24 INFO - Successfully installed blobuploader requests docopt 00:57:24 INFO - Cleaning up... 00:57:25 INFO - Return code: 0 00:57:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:57: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')]} 00:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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')]} 00:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:25 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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:25 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 00:57:25 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 00:57:25 INFO - Using env: {'DISPLAY': ':0', 00:57:25 INFO - 'HOME': '/home/cltbld', 00:57:25 INFO - 'LANG': 'en_US.UTF-8', 00:57:25 INFO - 'LANGUAGE': 'en_US:en', 00:57:25 INFO - 'LOGNAME': 'cltbld', 00:57:25 INFO - 'MAIL': '/var/mail/cltbld', 00:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:25 INFO - 'MOZ_NO_REMOTE': '1', 00:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:25 INFO - 'NO_EM_RESTART': '1', 00:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:25 INFO - 'PWD': '/builds/slave/test', 00:57:25 INFO - 'SHELL': '/bin/bash', 00:57:25 INFO - 'SHLVL': '1', 00:57:25 INFO - 'TERM': 'linux', 00:57:25 INFO - 'TMOUT': '86400', 00:57:25 INFO - 'USER': 'cltbld', 00:57:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:25 INFO - '_': '/tools/buildbot/bin/python'} 00:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:57:25 INFO - Running setup.py (path:/tmp/pip-HGIW0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:57:25 INFO - Running setup.py (path:/tmp/pip-UJzxJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:57:25 INFO - Running setup.py (path:/tmp/pip-XhmUuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:57:25 INFO - Running setup.py (path:/tmp/pip-dXbPGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:57:25 INFO - Running setup.py (path:/tmp/pip-DWZTDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:57:25 INFO - Running setup.py (path:/tmp/pip-kNLUNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:57:25 INFO - Running setup.py (path:/tmp/pip-wYSTyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:57:25 INFO - Running setup.py (path:/tmp/pip-NJE_hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:57:25 INFO - Running setup.py (path:/tmp/pip-CPgxlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:57:25 INFO - Running setup.py (path:/tmp/pip-cOpXgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:57:25 INFO - Running setup.py (path:/tmp/pip-33v3Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:57:26 INFO - Running setup.py (path:/tmp/pip-5Cbg_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:57:26 INFO - Running setup.py (path:/tmp/pip-GaBnJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:57:26 INFO - Running setup.py (path:/tmp/pip-fFslOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:26 INFO - Running setup.py (path:/tmp/pip-smuzBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:57:26 INFO - Running setup.py (path:/tmp/pip-KFa_GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:57:26 INFO - Running setup.py (path:/tmp/pip-8t5AAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:57:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:57:26 INFO - Running setup.py install for manifestparser 00:57:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:57:26 INFO - Running setup.py install for mozcrash 00:57:26 INFO - Running setup.py install for mozdebug 00:57:26 INFO - Running setup.py install for mozdevice 00:57:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:57:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:57:26 INFO - Running setup.py install for mozfile 00:57:26 INFO - Running setup.py install for mozhttpd 00:57:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Running setup.py install for mozinfo 00:57:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Running setup.py install for mozInstall 00:57:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Running setup.py install for mozleak 00:57:27 INFO - Running setup.py install for mozlog 00:57:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Running setup.py install for moznetwork 00:57:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Running setup.py install for mozprocess 00:57:27 INFO - Running setup.py install for mozprofile 00:57:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Running setup.py install for mozrunner 00:57:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:57:27 INFO - Running setup.py install for mozscreenshot 00:57:28 INFO - Running setup.py install for moztest 00:57:28 INFO - Running setup.py install for mozversion 00:57:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:57:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:57:28 INFO - Cleaning up... 00:57:28 INFO - Return code: 0 00:57:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:28 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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:28 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 00:57:28 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 00:57:28 INFO - Using env: {'DISPLAY': ':0', 00:57:28 INFO - 'HOME': '/home/cltbld', 00:57:28 INFO - 'LANG': 'en_US.UTF-8', 00:57:28 INFO - 'LANGUAGE': 'en_US:en', 00:57:28 INFO - 'LOGNAME': 'cltbld', 00:57:28 INFO - 'MAIL': '/var/mail/cltbld', 00:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:28 INFO - 'MOZ_NO_REMOTE': '1', 00:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:28 INFO - 'NO_EM_RESTART': '1', 00:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:28 INFO - 'PWD': '/builds/slave/test', 00:57:28 INFO - 'SHELL': '/bin/bash', 00:57:28 INFO - 'SHLVL': '1', 00:57:28 INFO - 'TERM': 'linux', 00:57:28 INFO - 'TMOUT': '86400', 00:57:28 INFO - 'USER': 'cltbld', 00:57:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:28 INFO - '_': '/tools/buildbot/bin/python'} 00:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:57:28 INFO - Running setup.py (path:/tmp/pip-BSD6V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:57:28 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)) 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:57:28 INFO - Running setup.py (path:/tmp/pip-qyMHNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:57:28 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)) 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:57:28 INFO - Running setup.py (path:/tmp/pip-Gtq4bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:57:28 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)) 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:57:28 INFO - Running setup.py (path:/tmp/pip-RDi7xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:57:28 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)) 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:57:28 INFO - Running setup.py (path:/tmp/pip-mKxCZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:57:28 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)) 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:57:28 INFO - Running setup.py (path:/tmp/pip-FxQdxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:57:28 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)) 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:57:28 INFO - Running setup.py (path:/tmp/pip-R58eT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:57:28 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)) 00:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:57:28 INFO - Running setup.py (path:/tmp/pip-zd36n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:57:29 INFO - Running setup.py (path:/tmp/pip-vK0qbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:57:29 INFO - Running setup.py (path:/tmp/pip-JXh7MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:57:29 INFO - Running setup.py (path:/tmp/pip-enH8Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:57:29 INFO - Running setup.py (path:/tmp/pip-IDtN4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:57:29 INFO - Running setup.py (path:/tmp/pip-yG5M8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:57:29 INFO - Running setup.py (path:/tmp/pip-1RFg2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:29 INFO - Running setup.py (path:/tmp/pip-RAJkka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:57:29 INFO - Running setup.py (path:/tmp/pip-jm7V4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:57:29 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)) 00:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:57:29 INFO - Running setup.py (path:/tmp/pip-SQdlKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:57:29 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)) 00:57:29 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)) 00:57:29 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)) 00:57:29 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)) 00:57:29 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)) 00:57:29 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)) 00:57:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:57:29 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 00:57:29 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 00:57:29 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 00:57:29 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 00:57:29 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 00:57:29 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 00:57:31 INFO - Downloading blessings-1.6.tar.gz 00:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:57:31 INFO - Installing collected packages: blessings 00:57:31 INFO - Running setup.py install for blessings 00:57:31 INFO - Successfully installed blessings 00:57:31 INFO - Cleaning up... 00:57:31 INFO - Return code: 0 00:57:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:32 INFO - Reading from file tmpfile_stdout 00:57:32 INFO - Current package versions: 00:57:32 INFO - argparse == 1.2.1 00:57:32 INFO - blessings == 1.6 00:57:32 INFO - blobuploader == 1.2.4 00:57:32 INFO - docopt == 0.6.1 00:57:32 INFO - functools32 == 3.2.3-2 00:57:32 INFO - jsonschema == 2.5.1 00:57:32 INFO - manifestparser == 1.1 00:57:32 INFO - mozInstall == 1.12 00:57:32 INFO - mozcrash == 0.17 00:57:32 INFO - mozdebug == 0.1 00:57:32 INFO - mozdevice == 0.48 00:57:32 INFO - mozfile == 1.2 00:57:32 INFO - mozhttpd == 0.7 00:57:32 INFO - mozinfo == 0.9 00:57:32 INFO - mozleak == 0.1 00:57:32 INFO - mozlog == 3.3 00:57:32 INFO - moznetwork == 0.27 00:57:32 INFO - mozprocess == 0.23 00:57:32 INFO - mozprofile == 0.28 00:57:32 INFO - mozrunner == 6.12 00:57:32 INFO - mozscreenshot == 0.1 00:57:32 INFO - mozsystemmonitor == 0.3 00:57:32 INFO - moztest == 0.7 00:57:32 INFO - mozversion == 1.4 00:57:32 INFO - psutil == 3.1.1 00:57:32 INFO - requests == 1.2.3 00:57:32 INFO - wsgiref == 0.1.2 00:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:57: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')]} 00:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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')]} 00:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:32 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 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:32 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 00:57:32 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 00:57:32 INFO - Using env: {'DISPLAY': ':0', 00:57:32 INFO - 'HOME': '/home/cltbld', 00:57:32 INFO - 'LANG': 'en_US.UTF-8', 00:57:32 INFO - 'LANGUAGE': 'en_US:en', 00:57:32 INFO - 'LOGNAME': 'cltbld', 00:57:32 INFO - 'MAIL': '/var/mail/cltbld', 00:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:32 INFO - 'MOZ_NO_REMOTE': '1', 00:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:32 INFO - 'NO_EM_RESTART': '1', 00:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:32 INFO - 'PWD': '/builds/slave/test', 00:57:32 INFO - 'SHELL': '/bin/bash', 00:57:32 INFO - 'SHLVL': '1', 00:57:32 INFO - 'TERM': 'linux', 00:57:32 INFO - 'TMOUT': '86400', 00:57:32 INFO - 'USER': 'cltbld', 00:57:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:32 INFO - '_': '/tools/buildbot/bin/python'} 00:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 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)) 00:57:32 INFO - Cleaning up... 00:57:32 INFO - Return code: 0 00:57:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:57: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')]} 00:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57: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')]} 00:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cf82a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, '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': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', '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 00:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:57:32 INFO - Using env: {'DISPLAY': ':0', 00:57:32 INFO - 'HOME': '/home/cltbld', 00:57:32 INFO - 'LANG': 'en_US.UTF-8', 00:57:32 INFO - 'LANGUAGE': 'en_US:en', 00:57:32 INFO - 'LOGNAME': 'cltbld', 00:57:32 INFO - 'MAIL': '/var/mail/cltbld', 00:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:32 INFO - 'MOZ_NO_REMOTE': '1', 00:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:32 INFO - 'NO_EM_RESTART': '1', 00:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:32 INFO - 'PWD': '/builds/slave/test', 00:57:32 INFO - 'SHELL': '/bin/bash', 00:57:32 INFO - 'SHLVL': '1', 00:57:32 INFO - 'TERM': 'linux', 00:57:32 INFO - 'TMOUT': '86400', 00:57:32 INFO - 'USER': 'cltbld', 00:57:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:32 INFO - '_': '/tools/buildbot/bin/python'} 00:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:57:32 INFO - Cleaning up... 00:57:32 INFO - Return code: 0 00:57:32 INFO - Running post-action listener: _resource_record_post_action 00:57:32 INFO - Running post-action listener: _start_resource_monitoring 00:57:32 INFO - Starting resource monitoring. 00:57:32 INFO - [mozharness: 2016-08-19 07:57:32.493253Z] Finished create-virtualenv step (success) 00:57:32 INFO - [mozharness: 2016-08-19 07:57:32.493704Z] Running install step. 00:57:32 INFO - Running pre-action listener: _resource_record_pre_action 00:57:32 INFO - Running main action method: install 00:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:32 INFO - Reading from file tmpfile_stdout 00:57:32 INFO - Detecting whether we're running mozinstall >=1.0... 00:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:57:32 INFO - Reading from file tmpfile_stdout 00:57:32 INFO - Output received: 00:57:32 INFO - Usage: mozinstall [options] installer 00:57:32 INFO - Options: 00:57:32 INFO - -h, --help show this help message and exit 00:57:32 INFO - -d DEST, --destination=DEST 00:57:32 INFO - Directory to install application into. [default: 00:57:32 INFO - "/builds/slave/test"] 00:57:32 INFO - --app=APP Application being installed. [default: firefox] 00:57:32 INFO - mkdir: /builds/slave/test/build/application 00:57:32 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'] 00:57:32 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 00:57:49 INFO - Reading from file tmpfile_stdout 00:57:49 INFO - Output received: 00:57:49 INFO - /builds/slave/test/build/application/firefox/firefox 00:57:49 INFO - Running post-action listener: _resource_record_post_action 00:57:49 INFO - [mozharness: 2016-08-19 07:57:49.739672Z] Finished install step (success) 00:57:49 INFO - [mozharness: 2016-08-19 07:57:49.739920Z] Running run-tests step. 00:57:49 INFO - Running pre-action listener: _resource_record_pre_action 00:57:49 INFO - Running main action method: run_tests 00:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:57:49 INFO - Python 2.7.3 00:57:49 INFO - Return code: 0 00:57:49 INFO - grabbing minidump binary from tooltool 00:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:49 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 0x18c0370>, '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 0x18c38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:57:49 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 00:57:49 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 00:57:49 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 00:57:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:57:49 INFO - Return code: 0 00:57:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:57:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:57:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:57:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:57:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:57:49 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/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 00:57:49 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/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 00:57:49 INFO - Using env: {'DISPLAY': ':0', 00:57:49 INFO - 'HOME': '/home/cltbld', 00:57:49 INFO - 'LANG': 'en_US.UTF-8', 00:57:49 INFO - 'LANGUAGE': 'en_US:en', 00:57:49 INFO - 'LOGNAME': 'cltbld', 00:57:49 INFO - 'MAIL': '/var/mail/cltbld', 00:57:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:57:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:49 INFO - 'MOZ_NO_REMOTE': '1', 00:57:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:49 INFO - 'NO_EM_RESTART': '1', 00:57:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:49 INFO - 'PWD': '/builds/slave/test', 00:57:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:57:49 INFO - 'SHELL': '/bin/bash', 00:57:49 INFO - 'SHLVL': '1', 00:57:49 INFO - 'TERM': 'linux', 00:57:49 INFO - 'TMOUT': '86400', 00:57:49 INFO - 'USER': 'cltbld', 00:57:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219', 00:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:49 INFO - '_': '/tools/buildbot/bin/python'} 00:57:49 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/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 00:57:50 INFO - mozversion application_buildid: 20160818203024 00:57:50 INFO - mozversion application_changeset: 095ec4971ffb722809e2b423d27d493cf693d3f9 00:57:50 INFO - mozversion application_display_name: Nightly 00:57:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:57:50 INFO - mozversion application_name: Firefox 00:57:50 INFO - mozversion application_remotingname: firefox 00:57:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:57:50 INFO - mozversion application_vendor: Mozilla 00:57:50 INFO - mozversion application_version: 51.0a1 00:57:50 INFO - mozversion platform_buildid: 20160818203024 00:57:50 INFO - mozversion platform_changeset: 095ec4971ffb722809e2b423d27d493cf693d3f9 00:57:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:57:50 INFO - mozversion platform_version: 51.0a1 00:57:50 INFO - using testdate: 1471593470 00:57:50 INFO - actual date: 1471593470 00:57:50 INFO - starting webserver on 'localhost:60920' 00:57:50 INFO - SUITE-START | Running 2 tests 00:57:50 INFO - TEST-START | dromaeo_css 00:57:50 INFO - operating with platform_type : linux_ 00:57:50 INFO - Initialising browser for dromaeo_css test... 00:57:50 INFO - TEST-INFO | started process 6907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6LC_oy/profile http://localhost:60920/getInfo.html) 00:57:53 INFO - PROCESS | 6907 | __metrics Screen width/height:1600/1200 00:57:53 INFO - PROCESS | 6907 | colorDepth:24 00:57:53 INFO - PROCESS | 6907 | Browser inner width/height: 1024/697 00:57:53 INFO - PROCESS | 6907 | __metrics 00:57:54 INFO - PROCESS | 6907 | 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" 00:57:54 INFO - PROCESS | 6907 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:57:54 INFO - PROCESS | 6907 | console.error: PushService: 00:57:54 INFO - PROCESS | 6907 | stateChangeProcessEnqueue: Error transitioning state 00:57:54 INFO - PROCESS | 6907 | UnknownError 00:57:55 INFO - TEST-INFO | 6907: exit 0 00:57:55 INFO - Browser initialized. 00:57:55 INFO - Running cycle 1/1 for dromaeo_css test... 00:57:55 INFO - TEST-INFO | started process 6989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6LC_oy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:58:07 INFO - PROCESS | 6989 | RSS: Main: 155717632 00:58:07 INFO - PROCESS | 6989 | 00:58:58 INFO - PROCESS | 6989 | 1471593538856 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:01:08 INFO - PROCESS | 6989 | Cycle 1(1): loaded http://localhost:60920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60920/tests/dromaeo/cssquery-ext.html) 01:01:09 INFO - PROCESS | 6989 | RSS: Main: 263688192 01:01:09 INFO - PROCESS | 6989 | 01:04:11 INFO - PROCESS | 6989 | Cycle 1(1): loaded http://localhost:60920/tests/dromaeo/cssquery-ext.html (next: http://localhost:60920/tests/dromaeo/cssquery-jquery.html) 01:04:12 INFO - PROCESS | 6989 | RSS: Main: 252809216 01:04:12 INFO - PROCESS | 6989 | 01:07:14 INFO - PROCESS | 6989 | Cycle 1(1): loaded http://localhost:60920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60920/tests/dromaeo/cssquery-mootools.html) 01:07:14 INFO - PROCESS | 6989 | RSS: Main: 183951360 01:07:14 INFO - PROCESS | 6989 | 01:10:17 INFO - PROCESS | 6989 | Cycle 1(1): loaded http://localhost:60920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60920/tests/dromaeo/cssquery-prototype.html) 01:10:17 INFO - PROCESS | 6989 | RSS: Main: 243003392 01:10:17 INFO - PROCESS | 6989 | 01:13:20 INFO - PROCESS | 6989 | Cycle 1(1): loaded http://localhost:60920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60920/tests/dromaeo/cssquery-yui.html) 01:13:20 INFO - PROCESS | 6989 | RSS: Main: 183689216 01:13:20 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | Cycle 1(1): loaded http://localhost:60920/tests/dromaeo/cssquery-yui.html (next: http://localhost:60920/tests/dromaeo/cssquery-dojo.html) 01:16:23 INFO - PROCESS | 6989 | RSS: Main: 278839296 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | __start_tp_report 01:16:23 INFO - PROCESS | 6989 | _x_x_mozilla_page_load 01:16:23 INFO - PROCESS | 6989 | _x_x_mozilla_page_load_details 01:16:23 INFO - PROCESS | 6989 | |i|pagename|runs| 01:16:23 INFO - PROCESS | 6989 | |0;dojo.html;3020.821879467008;3037.2103253154187;3045.3909218156373;3059.0516939748672;3078.5690003399527;5265.7893684252585;5318.202269659553;5360.463953604638;5465;5487.094629386152;5252.23842542832;5268.6575372600755;5303.920441193385;5400;5459.535939445152;4848.321235027099;4903;4952.034353301107;4966.081274964125;5022.974885125569;4940.234263689116;4958.479359667237;4980.726060066695;4994.500549945013;4995.075910956467;4813.374261346037;4828.372311599504;4853.538913803183;4859.271109333593;4968.354113965198;4795.112904112751;4801.879953001168;4808.567228949376;4811.13399588074;4924.335214745999;4831.661783675144;4848.127337079324;4852.733099679516;4868.586170175539;4894.461609222983;5152.896942061176;5303.814366497154;5338.145896656516;5344.759485823147;5390.056740070511;5779.393163717833;5798.10129429939;5835.854103647401;5843.035899076647;5848.970755146197;5811.506021988136;5845.883082338372;5855.297364316267;5856.707164641751;5864.970675146597;5158.690478571298;5319.281896943901;5375.865603359947;5392.1911713242935;5479.232907392969;5938.376470470538;5974.4324289192455;5981.043033114768;5995.700214989233;5998.070299103646;5763.250777398911;5768.307803063659;5777.653340799566;5778.104393818965;5781.94218057814;5603.6077474577205;5659.632123912015;5716.228309178207;5728.856778580485;5840.0071987762185;5757.740901659352;5759.481646651738;5761.9135712964335;5777.508911742465;5797.072468405035;5710.428957104256;5715.857103572361;5769.567282453832;5781.421857814269;5782.306123265235;4273.316269396882;4286.335617979218;4301.2257793597455;4326.524082350938;4396.582324679151;3910.335243008695;3911.4328422379167;3913.099987002948;3945.743526670757;3950.1902110067367;5429.511343979061;5429.918551221735;5431.456854314537;5463.644863083887;5483.725813709379;5587.966226248157;5752.798652047242;5790.623609465371;5795.420457954255;5819.76720931158;5476.58925580583;5477.096279113981;5483.533899618497;5489.313835770528;5523.861903452365;4961.032598643302;4968.925466118011;4970.850874473772;4971.151350595945;4984.925226121611;5809.506191973645;5877.265341832271;5901.380355062828;6072.969635151796;6074.787382441682;5765.077587585966;5773.595848290579;5780.277465316835;5821.592488525932;5827.446392592697;5940.495057920125;5962.850928726816;5966.970165149147;5971.462568368694;5987.730552125077;5384.488473595002;5570.637908535932;5654.802081927113;5692.260006199168;5703.0589952659;5808.477237048686;5812.070068788974;5817.621854579439;5831.825045248649;5859.414058594107;5649.717514124195;5689.288838895138;5700.629459085312;5701.144828275792;5702.572307076903;5447.700376479173;5533.501984821385;5601.159826026129;5627.831165065055;5635.267415235993;5586.357568879468;5587.413321601336;5590.86022849432;5628.324601047901;5638.379778224474;5692.971535142297;5694.572907031907;5726.198332233574;5729.656220626775;5744.138379243147;5274.907068754057;5369.812056578001;5458.344998600193;5555.527780138734;5562.777488900399 01:16:23 INFO - PROCESS | 6989 | |1;ext.html;592.9703514824258;609.5337067143635;618.4248648756654;633.2148136310973;635.5773410681896;44349;45584.772076139576;45770.08459830806;45892;49000.754996225056;46228.306575401395;46703.53296467035;46715.53284467154;46729.29906051404;46789.064218715605;8974.506402147896;9113;9117.954410227972;9121.680741174061;9128.45229286245;9028.729138125867;9068.682596109138;9087.95456022719;9105.863412048824;9117.179453849152;9103.54482275887;9174.770630734252;9178.357514973955;9185.081491850828;9194.77013074675;9104.271658267322;9133.36066475347;9136.771580710536;9147.313951453667;9149.862752058725;8989.505577193251;9059.275257979345;9068.410553314014;9070.365074444791;9086.68196613122;43636.56363436357;44251;44262.778686106685;44283.77858110689;44326.77836610829;3756.417755247941;3804.8287827047848;3852.4443026108543;3875.488559461812;4161.708680392374;33497.91944571642;33985.49021764676;34720.47919281213;35052;35854.82072589621;4311.805968731414;4350.804213810355;4378.9562104378865;4601.907961840778;4609.101225261075;352911;353415;353829;354360;354542;58889;59256.407435925954;59311.70344148252;59554.404455954886;59630.70184649049;63079.6846015767;63165.68417157885;63390.36609633937;63495.36504634895;63521;16748.748768768477;17001.48995530136;17009.574760631083;17012.31950721982;17027.233774480177;12902.225866448043;12930.224186548649;12967.481300748053;12968.80546791799;12974.156679815782;18469.168887400097;18611.627767444574;18670.90664546696;18690.439286821416;18776.71834922477;5865.589408741347;5965.791197308074;5985.9401405986255;5989.161517387569;6016.518678505709;873.8427083125099;1012.3419777144768;1032.2877214721818;1058.85705429766;1082.7293176705823;31444.842775785975;31641.20896977594;31894.68105318917;32441.89351590986;32597.837010814794;1093.8468614393992;1102.9503672334765;1141.6232643227715;1196.2762528670203;1217.2027322104036;16933.238004289837;16991;17079.316827327017;17087.316507339816;17277;550834;553270;554144;555389;555760;61510.077348839804;61533.692331538055;61585.384146157965;61793.69103154545;61803.38196618066;1224.4734764051543;1281.6155153453926;1316.927568983715;1368.6852024034529;1383.5710929611853;29772.717115488154;32905.50641740328;35256;35444.46833297554;35753.82123089368;54484.72757636187;55060;55125.72437137789;55172.448275516734;55256.44743552513;501033;508935;509224;509732;510792;46536;46830;47078;47192.29211561898;47196;49979.25031124609;50301.74849125731;50398.7480062612;53278;54115;41325.586744132175;43661.34507982319;43946.12107757763;44232.557674422846;44348;43022.56977430185;43423;43488.34767478427;43713;44197.779011104736;38814.61185388223;43541.564584355016;44054.11891762211;44139;44209.778951105036;35428.46857297194;38836;39520.802395987834;39790.403143953445;39958.800205998785;28965.275868103465;29319;29384.42229751493;29589.704102958694;29701.554476682435 01:16:23 INFO - PROCESS | 6989 | |2;jquery.html;397.50339970012925;402.5350719918495;413.32834144515164;413.43772469441564;428.54788198450643;13119.475220991173;18739.03240159784;19444.70832937507;19453.805461945376;20943;15234.162121083336;18778.906105469454;19325.13036913339;19388.127534260955;19794.10926508307;5825.592208545393;6000.099985002263;6032.336442991289;6034.36639152887;6036.547258955574;5700.344460387067;5863.032599621058;5874.88250234995;5934.792282270121;5965.910511342312;5902.232709747726;5904.261967254093;5905.143754155645;5908.291005079396;5909.9704501477645;5667.291588551431;5826.281247032136;5874.530037596982;5896.88206235875;5896.911546326808;5201.973990130063;5226.660267082628;5234;5234.685918844882;5238.973805130988;23091.422714432272;23391.181308654115;23754.40613984647;23930.88034559816;24093;2348.4833336665906;2383.9041658575916;2416.5046165536023;2421.9636705449257;3022.319978004953;7171.677274522659;7177.569345839214;7887.921120788834;13994.580162595139;14641.121532708072;1945.5233467800338;1981.4154824326858;1983.308396999693;1991.950201244966;2024.342088821139;77439;85231;85413.57293213556;87335.12664873333;89071;11323.603673871376;11326.716832079264;11455.59905403307;11699;11711.355875426763;16030.919845400931;16032;16051.598710032109;16071.758923616155;16079.35682572684;7553.962230188924;7835.138134805167;7904.814277858367;7982.840343193104;8190.058143313595;7062.858742825115;7223.169335526377;7275;7289.927100728924;7671.117821450604;4327.480702315679;4395.780210989437;4460.30865215892;4621.653375996813;4679.742614156254;1801.7401505523615;2061.093119027623;2083.5728675621463;2116.4603026228215;2135.7223560936977;961.6489981156827;970.5244430229137;1010.9898901010896;1024.1960061351804;1099.4612639806437;19566.70649940252;19978;19996.700049499268;20062.49843753918;20500.282490112775;960.2174228004294;963.5904740485265;996.153269720746;999.7900440907491;1013.1843865688191;10695.304805187638;11004.174686898514;11063.834042489369;11088.501017454233;11162;476029;481008;483238;485361;486509;59306.703466482395;94807;95272;95935;96808;975.9414435133915;976.8730065091493;1018.2159737002614;1021.4688362051692;1043.6868939318326;17232.65534689274;17743.256743256745;18391.356302529348;18405.631887362444;18766.6246675063;30994;37834.62165378311;39291;42571.574284258;42681.786591068085;58993.11510327263;59690.40309596848;62303;63112.053319201164;64278;7622.504537205064;8428.4942903426;8720.345974051845;9034.819303614022;9045.231155351868;11602.883971160518;12610.18033827835;12928.418221179882;12973.740525189254;13718.314084295946;11673.241239319417;11949.2830430171;11955.64133076009;12134.029277657943;12358.258504489759;10615.840762388416;10678.733031673959;10736.141108711441;10766.81565027862;10837.620683276047;12118.515259389525;12211.938940305241;12288.167152440376;12398.5660501882;12451.377431128589;8902.376833621584;9015.684451044182;9040.728778136667;9111.271098312252;9390.389624674373;11629.825552616549;11633.59282425111;11719.941400292944;11895.226810257305;12437.813432798695 01:16:23 INFO - PROCESS | 6989 | |3;mootools.html;1345.4618152738897;1474.292339676955;1515.6741300620365;1641.5321633334502;1768.8673349498783;8545.572721363931;9062;9063.093690630934;9342.346035777482;9350.485723285217;9116.954415227914;9166.816663666723;9193;9227.815443691123;9233.44599324041;2105.589410065038;2333.7666233376694;2431;2454.901803927841;2463.3718401807605;2439.731629520751;2462.642916777066;2463.273334366357;2464.938376540592;2471.3327401601555;2401.651760494727;2402.9639555406684;2411.3127758588807;2412.8793560322;2456.3245107595376;2332.346942856003;2403.122860156048;2407.277816655005;2409.903603855844;2416.2630397728685;2442.535918175541;2453.4847681986803;2475;2479.1446950801947;2482.11884780902;9272.07279272074;9313.348065635408;9396.389234699722;9428.481433521154;9433.76415589609;5377.462253774591;5515.034868897967;5520.585956053312;5523.171524271352;5532.30846144232;3445.776024558421;3552.8045957472327;3660.432632941872;3689.1330537323706;3710.2579484103017;1235.0613533714443;1245.2528482910272;1246.962591122268;1278.1117123599101;1290.2516540406637;12677;12830.807537886845;12862.292573908431;12867.09930304879;12892.677683057906;4782;4793.9041219176115;4806.8077276909235;4915.9508404916205;4967.776450059756;10752.892471075345;10755.193360497837;10759;10764.56941722338;10765.946170269099;5425.647332923426;5439.5376393006245;5446.183072539151;5456.7544460499375;5460.208269800856;4092.202020606013;4400.867973960786;4991.875203119951;4997.650164488451;5000.474950130184;4084.9795751021647;4142.431409884509;4166.270902592034;4217.608189297524;4228.302330115558;1312.4290933443983;1341.597520743773;1344.3143996561823;1346.3268365817091;1347.3802051056427;896.6054935828345;939.736873675372;1000.4847503535685;1004.8141093897652;1005.943759053006;6031.819045428644;6044.576879618472;6134.355892631299;6149.354317796657;6307.740682881127;485.3472080052324;487.2326086413912;491.1846335083815;495.62332627202863;510.51246060012596;4188.162367526507;4277.165952639268;4282.550819835311;4367.192069467159;4389.078293558325;10994.505247263733;11358.488868000959;11359;11359.545618175345;11360.431978401211;11264.380459074666;11272.549098035986;11347.319160850375;11357.091432685365;11390.145739069438;7978.521288722695;8291.253787159185;8302.584870756438;8303.626336814857;8318.126596707258;6154.815355539341;6183.443490085734;6204.968975155095;6214.689265536796;6275.968620157053;10265.486725663537;10490.160787136858;10616.363018218932;10665.253432259979;10673.839892401775;7487.775366739006;9819.312648114563;10512.316699414514;10722.981316774894;10742.086922611665;8004.5597492138495;8141.389395795458;8142.633581488729;8188.918110819054;8194.09864914847;7883.84232315362;7997.8400431992195;8047;8255.958720206361;8702.521361324934;7457.701691932479;7508.774736757906;7604.2395760423515;7707.34487568563;7710.460267781202;7549.0941087069905;7582.54504729718;7622.123455802654;7628.313451789366;7700.768976930701;6732.528722989344;6793.490488213502;6806.693698783468;6825.385715285648;7047.436205103682;5135.05001574695;5152.510511501401;5321.521063104339;5344.625876188629;5434.891302174014;5404.918926216189;5480.671159730429;5497.642653227527;5575.804846830341;5680.829575112588 01:16:23 INFO - PROCESS | 6989 | |4;prototype.html;332.0735148934473;341.56450525579885;348.46162678661466;353.33220213795914;357.80857241375867;5116.462771409004;5209.14049181885;5238.842834714955;5249.5012973767525;5250.4487028861995;5128.666636668614;5190.948090519103;5206.140986737193;5219.425863155059;5219.921701174486;3860.575336712959;4113.115680128764;4122.402251673506;4132.545420003812;4144.48193975753;3924.274009308273;3991.9600803992025;4002.299597570428;4041.454403655513;4096.242195193884;4030.8186131624;4051.5340735815316;4056.1482088761395;4064.4919385076864;4083.9795801020955;4017.4777278953547;4086.979565102185;4090.713650044498;4102.856400025999;4116.341385378325;3440.9827950860335;3472.826358682056;3627.673509384168;3646.908827279339;3655.190680613087;4996.450390457083;4998.850034498971;5000.749962501896;5004.424491183524;5006.347905191278;4643.744594047326;4655.557722016403;4658.254679251304;4659.184642687516;4664.696794708333;5206.219067139921;5317.680939143625;5340.839774806762;5349.251104845286;5351;3999.7800120993334;4014.3577027675724;4016.9397459038137;4030.8992275193064;4043.433919251307;5548.805791797267;5552.5280351170195;5568.3596386415675;5571.275734154575;5572.944270557283;3769.4911186989407;4009.8195581198916;4064.9796751016056;4069.9796501017304;4126.463559737215;4097.631213190827;4098.0124639549795;4116.094459218967;4120.855770048094;4138;4671.346011558385;4672.672912896132;4680.262046702649;4695.22528782747;4701.623870090384;5304.363476382781;5437.130059190589;5502.724863756876;5503.504684578327;5513.807016754395;1397.9166146236748;1411.2308791708545;1411.9294035298194;1417.5818133650598;1418.7869371687266;882.2589025218847;924.2098006204733;924.2421214604094;939.4457270210609;940.6707652321633;4635.397398338195;4638.234691275969;4652.930206046912;4657.208274593328;4975.701457912537;5324.760385782649;5452.781888724486;5472.452754724496;5478.780848766084;5490;5131;5139.612304677716;5144.2283657450935;5156.226566015052;5175.948240517622;2816.8732407041734;2879.92800179993;2902.9709702903124;2911.8398488082935;2912.766978641746;5653.717314134276;5654.886902262014;5663.943360566342;5669.773209071591;5672.205891175238;5610.354809196913;5612.438756124355;5637.379888212294;5637.605367624309;5658.688772117573;5417.51242388187;5652.74562644682;5654.5193658538665;5659.518940889988;5687.260656114679;5492.148716948879;5497.532709719719;5507.311586051744;5508.283923089973;5581.888362232814;5161.98024155873;5424.511793938406;5461.1262198048125;5469.617126801086;5551.333839939233;5648.406917273627;5679.858003549944;5713.400092990176;5726.4273572642405;5744.793593345445;4035.7174997749876;4048.2510735514024;4050.270951228807;4080.143169934347;4080.510338759368;5433.375161856279;5463.9180412294645;5526.41972592888;5576.609637325349;5631.239782629293;5332.760025798771;5345.866353341197;5350.6254562180275;5361.169018802092;5412.621116521806;5349.251104845247;5379.1393377059485;5381.381141168659;5383.623146379872;5423.9186412204635;5043.949560504348;5253.737313134252;5271.051210782096;5284.709340986283;5291.788328466818;5368.382635996911;5383.5423988961375;5419.729013549386;5426.267453893832;5438.673679579238;5035.29505869186;5113.488651134857;5231.006108839309;5237.450067742832;5241.711705856214 01:16:23 INFO - PROCESS | 6989 | |5;yui.html;773.1302284929453;776.5690042026673;788.1251810490355;858.3347905373339;913.2237598041663;14896.393131202038;16010.679786404266;16059.116748578852;16061.75907361389;16142.596435089128;15624.375024999015;15736;15769.132697701622;15769.369225231007;15771.21143942804;669.4142625202948;786.4966421490223;822.4777266435797;825.7110011495988;831.5717405536154;823.2426167925523;826.3760860550276;826.946248493849;826.983460330793;827.400134902194;706.6537396675643;875.7810547363159;877.5656050255133;878.3368556739653;879.9912000880005;721.3832173491668;730.9780706578811;849.851276026699;871.7646235516438;875.7197696737047;632.5414074795782;636.4431122767578;636.6625688385163;636.6912047656883;636.7834936121694;14018.158910465405;14045.367958441895;14081.084729492653;14147.717045659132;14162;14636.926815365856;14660.266986650624;14746;14841.183734894577;14938.32777525014;13313.26777027263;13353.933230333787;13402.798958015637;13451.86548134516;13523.661908452268;4374.19077470669;4408.184485870092;4551.112533056055;4553.339765733983;4578.954210457886;82572.17427825705;83584;83783.58108209481;84530.15469845284;84649;10835.78328433427;11754.588589399329;11770.411479425995;11885.28688278706;11930.164888457724;20233.494162646053;21445.78554214438;21481;21560.78439215619;21586.78413215879;8760.51817150063;8851.424657397378;9016.368854180144;9028.593713282919;9494.810103797885;4965.1807451770055;5020.648554601216;5045.571126454292;5072.847814565569;5117.334746482933;3745.344564701221;3864.9227015459533;3878.4376265441915;3886.8639597613947;3922;686.6806934775353;689.7344522358928;703.6552089476222;705.1256442011868;708.9503734738622;683.6718375179942;695.0408436357794;699.7620808924888;745.5861996591943;752.657540818937;9465.290103242285;9471.526423678788;9574.760630984141;10017.141686282148;10608.41653709038;684.4708209693373;713.4149997002512;715.1596873673413;715.9309595269675;734.353768683555;4573.748443835621;4768.785404656799;4801.855944321676;4825.697061793297;4836.903261934812;68972.65513672499;70181;70202.64898675474;99471;111073.44463277631;63131;75598.62200688961;109274.45362773135;111322;113239.43380283046;93933.5303323479;98519.50740246396;98965.50517247367;99435.50282248542;103275;9052.456852588866;9300.488473134043;9407.905920940702;9408.153266206074;9557.61769529211;55111.371746066645;56465.717671413026;57515.7124214393;57524;57825;79199;82172.58913705393;84868;84955;89404.55297723469;12015.45930433115;12441;12497.437615307152;12533.686657833263;12765.808512872129;14137.43450261978;14285.64285892861;14320.928395357956;14360.497382591559;14585.270736463346;12872.098953073195;13030.218186908816;13072.346382681018;13264.403101860633;13341.799873001719;12442.81335779946;12520.436580353724;12535.749285014066;12537.435815388148;12575.87424125747;11865;12260.26438413698;12516.687082823002;12744.6813829655;12852;10779.622713205;11308.773824523629;11379.829302560634;11399.658010259705;11639.76720465603;10849.403282819521;11390.37352945596;11529.654110376701;11732.765344692887;11752.941235293769 01:16:23 INFO - PROCESS | 6989 | __end_tp_report 01:16:23 INFO - PROCESS | 6989 | __start_cc_report 01:16:23 INFO - PROCESS | 6989 | _x_x_mozilla_cycle_collect,954 01:16:23 INFO - PROCESS | 6989 | __end_cc_report 01:16:23 INFO - PROCESS | 6989 | __startTimestamp1471594583699__endTimestamp 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | ------- Summary: start ------- 01:16:23 INFO - PROCESS | 6989 | Number of tests: 6 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | [#0] dojo.html Cycles:165 Average:5351.27 Median:5562.78 stddev:629.52 (11.3%) stddev-sans-first:604.32 01:16:23 INFO - PROCESS | 6989 | Values: 3020.8 3037.2 3045.4 3059.1 3078.6 5265.8 5318.2 5360.5 5465.0 5487.1 5252.2 5268.7 5303.9 5400.0 5459.5 4848.3 4903.0 4952.0 4966.1 5023.0 4940.2 4958.5 4980.7 4994.5 4995.1 4813.4 4828.4 4853.5 4859.3 4968.4 4795.1 4801.9 4808.6 4811.1 4924.3 4831.7 4848.1 4852.7 4868.6 4894.5 5152.9 5303.8 5338.1 5344.8 5390.1 5779.4 5798.1 5835.9 5843.0 5849.0 5811.5 5845.9 5855.3 5856.7 5865.0 5158.7 5319.3 5375.9 5392.2 5479.2 5938.4 5974.4 5981.0 5995.7 5998.1 5763.3 5768.3 5777.7 5778.1 5781.9 5603.6 5659.6 5716.2 5728.9 5840.0 5757.7 5759.5 5761.9 5777.5 5797.1 5710.4 5715.9 5769.6 5781.4 5782.3 4273.3 4286.3 4301.2 4326.5 4396.6 3910.3 3911.4 3913.1 3945.7 3950.2 5429.5 5429.9 5431.5 5463.6 5483.7 5588.0 5752.8 5790.6 5795.4 5819.8 5476.6 5477.1 5483.5 5489.3 5523.9 4961.0 4968.9 4970.9 4971.2 4984.9 5809.5 5877.3 5901.4 6073.0 6074.8 5765.1 5773.6 5780.3 5821.6 5827.4 5940.5 5962.9 5967.0 5971.5 5987.7 5384.5 5570.6 5654.8 5692.3 5703.1 5808.5 5812.1 5817.6 5831.8 5859.4 5649.7 5689.3 5700.6 5701.1 5702.6 5447.7 5533.5 5601.2 5627.8 5635.3 5586.4 5587.4 5590.9 5628.3 5638.4 5693.0 5694.6 5726.2 5729.7 5744.1 5274.9 5369.8 5458.3 5555.5 5562.8 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | [#1] ext.html Cycles:180 Average:64404.85 Median:44337.39 stddev:127185.67 (286.9%) stddev-sans-first:127452.22 01:16:23 INFO - PROCESS | 6989 | Values: 593.0 609.5 618.4 633.2 635.6 44349.0 45584.8 45770.1 45892.0 49000.8 46228.3 46703.5 46715.5 46729.3 46789.1 8974.5 9113.0 9118.0 9121.7 9128.5 9028.7 9068.7 9088.0 9105.9 9117.2 9103.5 9174.8 9178.4 9185.1 9194.8 9104.3 9133.4 9136.8 9147.3 9149.9 8989.5 9059.3 9068.4 9070.4 9086.7 43636.6 44251.0 44262.8 44283.8 44326.8 3756.4 3804.8 3852.4 3875.5 4161.7 33497.9 33985.5 34720.5 35052.0 35854.8 4311.8 4350.8 4379.0 4601.9 4609.1 352911.0 353415.0 353829.0 354360.0 354542.0 58889.0 59256.4 59311.7 59554.4 59630.7 63079.7 63165.7 63390.4 63495.4 63521.0 16748.7 17001.5 17009.6 17012.3 17027.2 12902.2 12930.2 12967.5 12968.8 12974.2 18469.2 18611.6 18670.9 18690.4 18776.7 5865.6 5965.8 5985.9 5989.2 6016.5 873.8 1012.3 1032.3 1058.9 1082.7 31444.8 31641.2 31894.7 32441.9 32597.8 1093.8 1103.0 1141.6 1196.3 1217.2 16933.2 16991.0 17079.3 17087.3 17277.0 550834.0 553270.0 554144.0 555389.0 555760.0 61510.1 61533.7 61585.4 61793.7 61803.4 1224.5 1281.6 1316.9 1368.7 1383.6 29772.7 32905.5 35256.0 35444.5 35753.8 54484.7 55060.0 55125.7 55172.4 55256.4 501033.0 508935.0 509224.0 509732.0 510792.0 46536.0 46830.0 47078.0 47192.3 47196.0 49979.3 50301.7 50398.7 53278.0 54115.0 41325.6 43661.3 43946.1 44232.6 44348.0 43022.6 43423.0 43488.3 43713.0 44197.8 38814.6 43541.6 44054.1 44139.0 44209.8 35428.5 38836.0 39520.8 39790.4 39958.8 28965.3 29319.0 29384.4 29589.7 29701.6 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | [#2] jquery.html Cycles:180 Average:28868.46 Median:38562.81 stddev:79650.39 (206.5%) stddev-sans-first:79845.15 01:16:23 INFO - PROCESS | 6989 | Values: 397.5 402.5 413.3 413.4 428.5 13119.5 18739.0 19444.7 19453.8 20943.0 15234.2 18778.9 19325.1 19388.1 19794.1 5825.6 6000.1 6032.3 6034.4 6036.5 5700.3 5863.0 5874.9 5934.8 5965.9 5902.2 5904.3 5905.1 5908.3 5910.0 5667.3 5826.3 5874.5 5896.9 5896.9 5202.0 5226.7 5234.0 5234.7 5239.0 23091.4 23391.2 23754.4 23930.9 24093.0 2348.5 2383.9 2416.5 2422.0 3022.3 7171.7 7177.6 7887.9 13994.6 14641.1 1945.5 1981.4 1983.3 1992.0 2024.3 77439.0 85231.0 85413.6 87335.1 89071.0 11323.6 11326.7 11455.6 11699.0 11711.4 16030.9 16032.0 16051.6 16071.8 16079.4 7554.0 7835.1 7904.8 7982.8 8190.1 7062.9 7223.2 7275.0 7289.9 7671.1 4327.5 4395.8 4460.3 4621.7 4679.7 1801.7 2061.1 2083.6 2116.5 2135.7 961.6 970.5 1011.0 1024.2 1099.5 19566.7 19978.0 19996.7 20062.5 20500.3 960.2 963.6 996.2 999.8 1013.2 10695.3 11004.2 11063.8 11088.5 11162.0 476029.0 481008.0 483238.0 485361.0 486509.0 59306.7 94807.0 95272.0 95935.0 96808.0 975.9 976.9 1018.2 1021.5 1043.7 17232.7 17743.3 18391.4 18405.6 18766.6 30994.0 37834.6 39291.0 42571.6 42681.8 58993.1 59690.4 62303.0 63112.1 64278.0 7622.5 8428.5 8720.3 9034.8 9045.2 11602.9 12610.2 12928.4 12973.7 13718.3 11673.2 11949.3 11955.6 12134.0 12358.3 10615.8 10678.7 10736.1 10766.8 10837.6 12118.5 12211.9 12288.2 12398.6 12451.4 8902.4 9015.7 9040.7 9111.3 9390.4 11629.8 11633.6 11719.9 11895.2 12437.8 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | [#3] mootools.html Cycles:180 Average:5951.49 Median:2646.08 stddev:3401.65 (128.6%) stddev-sans-first:3393.58 01:16:23 INFO - PROCESS | 6989 | Values: 1345.5 1474.3 1515.7 1641.5 1768.9 8545.6 9062.0 9063.1 9342.3 9350.5 9117.0 9166.8 9193.0 9227.8 9233.4 2105.6 2333.8 2431.0 2454.9 2463.4 2439.7 2462.6 2463.3 2464.9 2471.3 2401.7 2403.0 2411.3 2412.9 2456.3 2332.3 2403.1 2407.3 2409.9 2416.3 2442.5 2453.5 2475.0 2479.1 2482.1 9272.1 9313.3 9396.4 9428.5 9433.8 5377.5 5515.0 5520.6 5523.2 5532.3 3445.8 3552.8 3660.4 3689.1 3710.3 1235.1 1245.3 1247.0 1278.1 1290.3 12677.0 12830.8 12862.3 12867.1 12892.7 4782.0 4793.9 4806.8 4916.0 4967.8 10752.9 10755.2 10759.0 10764.6 10765.9 5425.6 5439.5 5446.2 5456.8 5460.2 4092.2 4400.9 4991.9 4997.7 5000.5 4085.0 4142.4 4166.3 4217.6 4228.3 1312.4 1341.6 1344.3 1346.3 1347.4 896.6 939.7 1000.5 1004.8 1005.9 6031.8 6044.6 6134.4 6149.4 6307.7 485.3 487.2 491.2 495.6 510.5 4188.2 4277.2 4282.6 4367.2 4389.1 10994.5 11358.5 11359.0 11359.5 11360.4 11264.4 11272.5 11347.3 11357.1 11390.1 7978.5 8291.3 8302.6 8303.6 8318.1 6154.8 6183.4 6205.0 6214.7 6276.0 10265.5 10490.2 10616.4 10665.3 10673.8 7487.8 9819.3 10512.3 10723.0 10742.1 8004.6 8141.4 8142.6 8188.9 8194.1 7883.8 7997.8 8047.0 8256.0 8702.5 7457.7 7508.8 7604.2 7707.3 7710.5 7549.1 7582.5 7622.1 7628.3 7700.8 6732.5 6793.5 6806.7 6825.4 7047.4 5135.1 5152.5 5321.5 5344.6 5434.9 5404.9 5480.7 5497.6 5575.8 5680.8 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | [#4] prototype.html Cycles:180 Average:4543.45 Median:5183.45 stddev:1312.35 (25.3%) stddev-sans-first:1277.39 01:16:23 INFO - PROCESS | 6989 | Values: 332.1 341.6 348.5 353.3 357.8 5116.5 5209.1 5238.8 5249.5 5250.4 5128.7 5190.9 5206.1 5219.4 5219.9 3860.6 4113.1 4122.4 4132.5 4144.5 3924.3 3992.0 4002.3 4041.5 4096.2 4030.8 4051.5 4056.1 4064.5 4084.0 4017.5 4087.0 4090.7 4102.9 4116.3 3441.0 3472.8 3627.7 3646.9 3655.2 4996.5 4998.9 5000.7 5004.4 5006.3 4643.7 4655.6 4658.3 4659.2 4664.7 5206.2 5317.7 5340.8 5349.3 5351.0 3999.8 4014.4 4016.9 4030.9 4043.4 5548.8 5552.5 5568.4 5571.3 5572.9 3769.5 4009.8 4065.0 4070.0 4126.5 4097.6 4098.0 4116.1 4120.9 4138.0 4671.3 4672.7 4680.3 4695.2 4701.6 5304.4 5437.1 5502.7 5503.5 5513.8 1397.9 1411.2 1411.9 1417.6 1418.8 882.3 924.2 924.2 939.4 940.7 4635.4 4638.2 4652.9 4657.2 4975.7 5324.8 5452.8 5472.5 5478.8 5490.0 5131.0 5139.6 5144.2 5156.2 5175.9 2816.9 2879.9 2903.0 2911.8 2912.8 5653.7 5654.9 5663.9 5669.8 5672.2 5610.4 5612.4 5637.4 5637.6 5658.7 5417.5 5652.7 5654.5 5659.5 5687.3 5492.1 5497.5 5507.3 5508.3 5581.9 5162.0 5424.5 5461.1 5469.6 5551.3 5648.4 5679.9 5713.4 5726.4 5744.8 4035.7 4048.3 4050.3 4080.1 4080.5 5433.4 5463.9 5526.4 5576.6 5631.2 5332.8 5345.9 5350.6 5361.2 5412.6 5349.3 5379.1 5381.4 5383.6 5423.9 5043.9 5253.7 5271.1 5284.7 5291.8 5368.4 5383.5 5419.7 5426.3 5438.7 5035.3 5113.5 5231.0 5237.5 5241.7 01:16:23 INFO - PROCESS | 6989 | 01:16:23 INFO - PROCESS | 6989 | [#5] yui.html Cycles:180 Average:20825.58 Median:4831.30 stddev:29613.21 (612.9%) stddev-sans-first:29658.01 01:16:23 INFO - PROCESS | 6989 | Values: 773.1 776.6 788.1 858.3 913.2 14896.4 16010.7 16059.1 16061.8 16142.6 15624.4 15736.0 15769.1 15769.4 15771.2 669.4 786.5 822.5 825.7 831.6 823.2 826.4 826.9 827.0 827.4 706.7 875.8 877.6 878.3 880.0 721.4 731.0 849.9 871.8 875.7 632.5 636.4 636.7 636.7 636.8 14018.2 14045.4 14081.1 14147.7 14162.0 14636.9 14660.3 14746.0 14841.2 14938.3 13313.3 13353.9 13402.8 13451.9 13523.7 4374.2 4408.2 4551.1 4553.3 4579.0 82572.2 83584.0 83783.6 84530.2 84649.0 10835.8 11754.6 11770.4 11885.3 11930.2 20233.5 21445.8 21481.0 21560.8 21586.8 8760.5 8851.4 9016.4 9028.6 9494.8 4965.2 5020.6 5045.6 5072.8 5117.3 3745.3 3864.9 3878.4 3886.9 3922.0 686.7 689.7 703.7 705.1 709.0 683.7 695.0 699.8 745.6 752.7 9465.3 9471.5 9574.8 10017.1 10608.4 684.5 713.4 715.2 715.9 734.4 4573.7 4768.8 4801.9 4825.7 4836.9 68972.7 70181.0 70202.6 99471.0 111073.4 63131.0 75598.6 109274.5 111322.0 113239.4 93933.5 98519.5 98965.5 99435.5 103275.0 9052.5 9300.5 9407.9 9408.2 9557.6 55111.4 56465.7 57515.7 57524.0 57825.0 79199.0 82172.6 84868.0 84955.0 89404.6 12015.5 12441.0 12497.4 12533.7 12765.8 14137.4 14285.6 14320.9 14360.5 14585.3 12872.1 13030.2 13072.3 13264.4 13341.8 12442.8 12520.4 12535.7 12537.4 12575.9 11865.0 12260.3 12516.7 12744.7 12852.0 10779.6 11308.8 11379.8 11399.7 11639.8 10849.4 11390.4 11529.7 11732.8 11752.9 01:16:23 INFO - PROCESS | 6989 | -------- Summary: end -------- 01:16:23 INFO - PROCESS | 6989 | 01:16:24 INFO - TEST-INFO | 6989: exit 0 01:16:24 INFO - TEST-OK | dromaeo_css | took 1114473ms 01:16:24 INFO - TEST-START | kraken 01:16:24 INFO - operating with platform_type : linux_ 01:16:24 INFO - Initialising browser for kraken test... 01:16:24 INFO - TEST-INFO | started process 7297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFvVRe/profile http://localhost:60920/getInfo.html) 01:16:28 INFO - PROCESS | 7297 | __metrics Screen width/height:1600/1200 01:16:28 INFO - PROCESS | 7297 | colorDepth:24 01:16:28 INFO - PROCESS | 7297 | Browser inner width/height: 1024/697 01:16:28 INFO - PROCESS | 7297 | __metrics 01:16:28 INFO - PROCESS | 7297 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:16:28 INFO - PROCESS | 7297 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:16:29 INFO - TEST-INFO | 7297: exit 0 01:16:29 INFO - Browser initialized. 01:16:29 INFO - Running cycle 1/1 for kraken test... 01:16:29 INFO - TEST-INFO | started process 7383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFvVRe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:41 INFO - PROCESS | 7383 | RSS: Main: 156626944 01:16:41 INFO - PROCESS | 7383 | 01:16:44 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60920/tests/kraken/driver.html?testName=audio-beat-detection) 01:16:45 INFO - PROCESS | 7383 | RSS: Main: 204255232 01:16:45 INFO - PROCESS | 7383 | 01:16:47 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60920/tests/kraken/driver.html?testName=audio-dft) 01:16:48 INFO - PROCESS | 7383 | RSS: Main: 195637248 01:16:48 INFO - PROCESS | 7383 | 01:16:51 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60920/tests/kraken/driver.html?testName=audio-fft) 01:16:52 INFO - PROCESS | 7383 | RSS: Main: 275955712 01:16:52 INFO - PROCESS | 7383 | 01:16:54 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60920/tests/kraken/driver.html?testName=audio-oscillator) 01:16:54 INFO - PROCESS | 7383 | RSS: Main: 186241024 01:16:54 INFO - PROCESS | 7383 | 01:16:56 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:16:57 INFO - PROCESS | 7383 | RSS: Main: 191008768 01:16:57 INFO - PROCESS | 7383 | 01:17:00 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60920/tests/kraken/driver.html?testName=imaging-darkroom) 01:17:01 INFO - PROCESS | 7383 | RSS: Main: 226361344 01:17:01 INFO - PROCESS | 7383 | 01:17:04 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60920/tests/kraken/driver.html?testName=imaging-desaturate) 01:17:05 INFO - PROCESS | 7383 | RSS: Main: 226607104 01:17:05 INFO - PROCESS | 7383 | 01:17:07 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60920/tests/kraken/driver.html?testName=json-parse-financial) 01:17:08 INFO - PROCESS | 7383 | RSS: Main: 225996800 01:17:08 INFO - PROCESS | 7383 | 01:17:09 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:17:10 INFO - PROCESS | 7383 | RSS: Main: 188801024 01:17:10 INFO - PROCESS | 7383 | 01:17:12 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:17:13 INFO - PROCESS | 7383 | RSS: Main: 196284416 01:17:13 INFO - PROCESS | 7383 | 01:17:15 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:17:15 INFO - PROCESS | 7383 | RSS: Main: 193871872 01:17:15 INFO - PROCESS | 7383 | 01:17:18 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:17:18 INFO - PROCESS | 7383 | RSS: Main: 187056128 01:17:18 INFO - PROCESS | 7383 | 01:17:21 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:17:22 INFO - PROCESS | 7383 | RSS: Main: 192626688 01:17:22 INFO - PROCESS | 7383 | 01:17:23 INFO - PROCESS | 7383 | Cycle 1(1): loaded http://localhost:60920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60920/tests/kraken/driver.html?testName=ai-astar) 01:17:24 INFO - PROCESS | 7383 | RSS: Main: 243527680 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | __start_tp_report 01:17:24 INFO - PROCESS | 7383 | _x_x_mozilla_page_load 01:17:24 INFO - PROCESS | 7383 | _x_x_mozilla_page_load_details 01:17:24 INFO - PROCESS | 7383 | |i|pagename|runs| 01:17:24 INFO - PROCESS | 7383 | |0;ai-astar;104;113;113;110;107;113;112;111;111;111 01:17:24 INFO - PROCESS | 7383 | |1;audio-beat-detection;151;116;118;183;122;119;140;121;163;117 01:17:24 INFO - PROCESS | 7383 | |2;audio-dft;162;162;161;160;159;162;159;161;160;161 01:17:24 INFO - PROCESS | 7383 | |3;audio-fft;75;75;74;108;75;75;75;74;100;76 01:17:24 INFO - PROCESS | 7383 | |4;audio-oscillator;85;85;124;90;85;85;115;85;85;122 01:17:24 INFO - PROCESS | 7383 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 01:17:24 INFO - PROCESS | 7383 | |6;imaging-darkroom;145;145;146;146;145;146;145;147;146;145 01:17:24 INFO - PROCESS | 7383 | |7;imaging-desaturate;96;96;96;95;94;95;94;94;95;95 01:17:24 INFO - PROCESS | 7383 | |8;json-parse-financial;51;50;51;50;51;54;51;50;52;51 01:17:24 INFO - PROCESS | 7383 | |9;json-stringify-tinderbox;62;63;62;62;63;61;61;61;63;65 01:17:24 INFO - PROCESS | 7383 | |10;stanford-crypto-aes;79;77;82;79;90;77;83;83;80;78 01:17:24 INFO - PROCESS | 7383 | |11;stanford-crypto-ccm;136;130;141;125;134;121;135;122;142;132 01:17:24 INFO - PROCESS | 7383 | |12;stanford-crypto-pbkdf2;167;167;163;171;167;165;164;163;167;163 01:17:24 INFO - PROCESS | 7383 | |13;stanford-crypto-sha256-iterative;64;64;65;63;62;64;73;63;64;62 01:17:24 INFO - PROCESS | 7383 | __end_tp_report 01:17:24 INFO - PROCESS | 7383 | __start_cc_report 01:17:24 INFO - PROCESS | 7383 | _x_x_mozilla_cycle_collect,1689 01:17:24 INFO - PROCESS | 7383 | __end_cc_report 01:17:24 INFO - PROCESS | 7383 | __startTimestamp1471594644233__endTimestamp 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | ------- Summary: start ------- 01:17:24 INFO - PROCESS | 7383 | Number of tests: 14 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.92 (2.6%) stddev-sans-first:1.92 01:17:24 INFO - PROCESS | 7383 | Values: 104.0 113.0 113.0 110.0 107.0 113.0 112.0 111.0 111.0 111.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:131.00 stddev:23.49 (17.9%) stddev-sans-first:24.19 01:17:24 INFO - PROCESS | 7383 | Values: 151.0 116.0 118.0 183.0 122.0 119.0 140.0 121.0 163.0 117.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 01:17:24 INFO - PROCESS | 7383 | Values: 162.0 162.0 161.0 160.0 159.0 162.0 159.0 161.0 160.0 161.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.44 (16.6%) stddev-sans-first:13.02 01:17:24 INFO - PROCESS | 7383 | Values: 75.0 75.0 74.0 108.0 75.0 75.0 75.0 74.0 100.0 76.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:16.94 (19.9%) stddev-sans-first:17.49 01:17:24 INFO - PROCESS | 7383 | Values: 85.0 85.0 124.0 90.0 85.0 85.0 115.0 85.0 85.0 122.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:17:24 INFO - PROCESS | 7383 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 01:17:24 INFO - PROCESS | 7383 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 145.0 147.0 146.0 145.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 01:17:24 INFO - PROCESS | 7383 | Values: 96.0 96.0 96.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 01:17:24 INFO - PROCESS | 7383 | Values: 51.0 50.0 51.0 50.0 51.0 54.0 51.0 50.0 52.0 51.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:1.32 01:17:24 INFO - PROCESS | 7383 | Values: 62.0 63.0 62.0 62.0 63.0 61.0 61.0 61.0 63.0 65.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:3.94 (4.9%) stddev-sans-first:4.12 01:17:24 INFO - PROCESS | 7383 | Values: 79.0 77.0 82.0 79.0 90.0 77.0 83.0 83.0 80.0 78.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:134.50 stddev:7.33 (5.5%) stddev-sans-first:7.62 01:17:24 INFO - PROCESS | 7383 | Values: 136.0 130.0 141.0 125.0 134.0 121.0 135.0 122.0 142.0 132.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:167.00 stddev:2.58 (1.5%) stddev-sans-first:2.70 01:17:24 INFO - PROCESS | 7383 | Values: 167.0 167.0 163.0 171.0 167.0 165.0 164.0 163.0 167.0 163.0 01:17:24 INFO - PROCESS | 7383 | 01:17:24 INFO - PROCESS | 7383 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:3.17 (5.0%) stddev-sans-first:3.36 01:17:24 INFO - PROCESS | 7383 | Values: 64.0 64.0 65.0 63.0 62.0 64.0 73.0 63.0 64.0 62.0 01:17:24 INFO - PROCESS | 7383 | -------- Summary: end -------- 01:17:24 INFO - PROCESS | 7383 | 01:17:25 INFO - TEST-INFO | 7383: exit 0 01:17:25 INFO - TEST-OK | kraken | took 60786ms 01:17:25 INFO - SUITE-END | took 1175s 01:17:25 INFO - Completed test suite (00:19:35) 01:17:25 INFO - javascript benchmark 01:17:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.821879467008, 3037.2103253154187, 3045.3909218156373, 3059.0516939748672, 3078.5690003399527, 5265.7893684252585, 5318.202269659553, 5360.463953604638, 5465.0, 5487.094629386152, 5252.23842542832, 5268.6575372600755, 5303.920441193385, 5400.0, 5459.535939445152, 4848.321235027099, 4903.0, 4952.034353301107, 4966.081274964125, 5022.974885125569, 4940.234263689116, 4958.479359667237, 4980.726060066695, 4994.500549945013, 4995.075910956467, 4813.374261346037, 4828.372311599504, 4853.538913803183, 4859.271109333593, 4968.354113965198, 4795.112904112751, 4801.879953001168, 4808.567228949376, 4811.13399588074, 4924.335214745999, 4831.661783675144, 4848.127337079324, 4852.733099679516, 4868.586170175539, 4894.461609222983, 5152.896942061176, 5303.814366497154, 5338.145896656516, 5344.759485823147, 5390.056740070511, 5779.393163717833, 5798.10129429939, 5835.854103647401, 5843.035899076647, 5848.970755146197, 5811.506021988136, 5845.883082338372, 5855.297364316267, 5856.707164641751, 5864.970675146597, 5158.690478571298, 5319.281896943901, 5375.865603359947, 5392.1911713242935, 5479.232907392969, 5938.376470470538, 5974.4324289192455, 5981.043033114768, 5995.700214989233, 5998.070299103646, 5763.250777398911, 5768.307803063659, 5777.653340799566, 5778.104393818965, 5781.94218057814, 5603.6077474577205, 5659.632123912015, 5716.228309178207, 5728.856778580485, 5840.0071987762185, 5757.740901659352, 5759.481646651738, 5761.9135712964335, 5777.508911742465, 5797.072468405035, 5710.428957104256, 5715.857103572361, 5769.567282453832, 5781.421857814269, 5782.306123265235, 4273.316269396882, 4286.335617979218, 4301.2257793597455, 4326.524082350938, 4396.582324679151, 3910.335243008695, 3911.4328422379167, 3913.099987002948, 3945.743526670757, 3950.1902110067367, 5429.511343979061, 5429.918551221735, 5431.456854314537, 5463.644863083887, 5483.725813709379, 5587.966226248157, 5752.798652047242, 5790.623609465371, 5795.420457954255, 5819.76720931158, 5476.58925580583, 5477.096279113981, 5483.533899618497, 5489.313835770528, 5523.861903452365, 4961.032598643302, 4968.925466118011, 4970.850874473772, 4971.151350595945, 4984.925226121611, 5809.506191973645, 5877.265341832271, 5901.380355062828, 6072.969635151796, 6074.787382441682, 5765.077587585966, 5773.595848290579, 5780.277465316835, 5821.592488525932, 5827.446392592697, 5940.495057920125, 5962.850928726816, 5966.970165149147, 5971.462568368694, 5987.730552125077, 5384.488473595002, 5570.637908535932, 5654.802081927113, 5692.260006199168, 5703.0589952659, 5808.477237048686, 5812.070068788974, 5817.621854579439, 5831.825045248649, 5859.414058594107, 5649.717514124195, 5689.288838895138, 5700.629459085312, 5701.144828275792, 5702.572307076903, 5447.700376479173, 5533.501984821385, 5601.159826026129, 5627.831165065055, 5635.267415235993, 5586.357568879468, 5587.413321601336, 5590.86022849432, 5628.324601047901, 5638.379778224474, 5692.971535142297, 5694.572907031907, 5726.198332233574, 5729.656220626775, 5744.138379243147, 5274.907068754057, 5369.812056578001, 5458.344998600193, 5555.527780138734, 5562.777488900399], "value": 5307.078431384374, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.9703514824258, 609.5337067143635, 618.4248648756654, 633.2148136310973, 635.5773410681896, 44349.0, 45584.772076139576, 45770.08459830806, 45892.0, 49000.754996225056, 46228.306575401395, 46703.53296467035, 46715.53284467154, 46729.29906051404, 46789.064218715605, 8974.506402147896, 9113.0, 9117.954410227972, 9121.680741174061, 9128.45229286245, 9028.729138125867, 9068.682596109138, 9087.95456022719, 9105.863412048824, 9117.179453849152, 9103.54482275887, 9174.770630734252, 9178.357514973955, 9185.081491850828, 9194.77013074675, 9104.271658267322, 9133.36066475347, 9136.771580710536, 9147.313951453667, 9149.862752058725, 8989.505577193251, 9059.275257979345, 9068.410553314014, 9070.365074444791, 9086.68196613122, 43636.56363436357, 44251.0, 44262.778686106685, 44283.77858110689, 44326.77836610829, 3756.417755247941, 3804.8287827047848, 3852.4443026108543, 3875.488559461812, 4161.708680392374, 33497.91944571642, 33985.49021764676, 34720.47919281213, 35052.0, 35854.82072589621, 4311.805968731414, 4350.804213810355, 4378.9562104378865, 4601.907961840778, 4609.101225261075, 352911.0, 353415.0, 353829.0, 354360.0, 354542.0, 58889.0, 59256.407435925954, 59311.70344148252, 59554.404455954886, 59630.70184649049, 63079.6846015767, 63165.68417157885, 63390.36609633937, 63495.36504634895, 63521.0, 16748.748768768477, 17001.48995530136, 17009.574760631083, 17012.31950721982, 17027.233774480177, 12902.225866448043, 12930.224186548649, 12967.481300748053, 12968.80546791799, 12974.156679815782, 18469.168887400097, 18611.627767444574, 18670.90664546696, 18690.439286821416, 18776.71834922477, 5865.589408741347, 5965.791197308074, 5985.9401405986255, 5989.161517387569, 6016.518678505709, 873.8427083125099, 1012.3419777144768, 1032.2877214721818, 1058.85705429766, 1082.7293176705823, 31444.842775785975, 31641.20896977594, 31894.68105318917, 32441.89351590986, 32597.837010814794, 1093.8468614393992, 1102.9503672334765, 1141.6232643227715, 1196.2762528670203, 1217.2027322104036, 16933.238004289837, 16991.0, 17079.316827327017, 17087.316507339816, 17277.0, 550834.0, 553270.0, 554144.0, 555389.0, 555760.0, 61510.077348839804, 61533.692331538055, 61585.384146157965, 61793.69103154545, 61803.38196618066, 1224.4734764051543, 1281.6155153453926, 1316.927568983715, 1368.6852024034529, 1383.5710929611853, 29772.717115488154, 32905.50641740328, 35256.0, 35444.46833297554, 35753.82123089368, 54484.72757636187, 55060.0, 55125.72437137789, 55172.448275516734, 55256.44743552513, 501033.0, 508935.0, 509224.0, 509732.0, 510792.0, 46536.0, 46830.0, 47078.0, 47192.29211561898, 47196.0, 49979.25031124609, 50301.74849125731, 50398.7480062612, 53278.0, 54115.0, 41325.586744132175, 43661.34507982319, 43946.12107757763, 44232.557674422846, 44348.0, 43022.56977430185, 43423.0, 43488.34767478427, 43713.0, 44197.779011104736, 38814.61185388223, 43541.564584355016, 44054.11891762211, 44139.0, 44209.778951105036, 35428.46857297194, 38836.0, 39520.802395987834, 39790.403143953445, 39958.800205998785, 28965.275868103465, 29319.0, 29384.42229751493, 29589.704102958694, 29701.554476682435], "value": 21052.266797147917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.50339970012925, 402.5350719918495, 413.32834144515164, 413.43772469441564, 428.54788198450643, 13119.475220991173, 18739.03240159784, 19444.70832937507, 19453.805461945376, 20943.0, 15234.162121083336, 18778.906105469454, 19325.13036913339, 19388.127534260955, 19794.10926508307, 5825.592208545393, 6000.099985002263, 6032.336442991289, 6034.36639152887, 6036.547258955574, 5700.344460387067, 5863.032599621058, 5874.88250234995, 5934.792282270121, 5965.910511342312, 5902.232709747726, 5904.261967254093, 5905.143754155645, 5908.291005079396, 5909.9704501477645, 5667.291588551431, 5826.281247032136, 5874.530037596982, 5896.88206235875, 5896.911546326808, 5201.973990130063, 5226.660267082628, 5234.0, 5234.685918844882, 5238.973805130988, 23091.422714432272, 23391.181308654115, 23754.40613984647, 23930.88034559816, 24093.0, 2348.4833336665906, 2383.9041658575916, 2416.5046165536023, 2421.9636705449257, 3022.319978004953, 7171.677274522659, 7177.569345839214, 7887.921120788834, 13994.580162595139, 14641.121532708072, 1945.5233467800338, 1981.4154824326858, 1983.308396999693, 1991.950201244966, 2024.342088821139, 77439.0, 85231.0, 85413.57293213556, 87335.12664873333, 89071.0, 11323.603673871376, 11326.716832079264, 11455.59905403307, 11699.0, 11711.355875426763, 16030.919845400931, 16032.0, 16051.598710032109, 16071.758923616155, 16079.35682572684, 7553.962230188924, 7835.138134805167, 7904.814277858367, 7982.840343193104, 8190.058143313595, 7062.858742825115, 7223.169335526377, 7275.0, 7289.927100728924, 7671.117821450604, 4327.480702315679, 4395.780210989437, 4460.30865215892, 4621.653375996813, 4679.742614156254, 1801.7401505523615, 2061.093119027623, 2083.5728675621463, 2116.4603026228215, 2135.7223560936977, 961.6489981156827, 970.5244430229137, 1010.9898901010896, 1024.1960061351804, 1099.4612639806437, 19566.70649940252, 19978.0, 19996.700049499268, 20062.49843753918, 20500.282490112775, 960.2174228004294, 963.5904740485265, 996.153269720746, 999.7900440907491, 1013.1843865688191, 10695.304805187638, 11004.174686898514, 11063.834042489369, 11088.501017454233, 11162.0, 476029.0, 481008.0, 483238.0, 485361.0, 486509.0, 59306.703466482395, 94807.0, 95272.0, 95935.0, 96808.0, 975.9414435133915, 976.8730065091493, 1018.2159737002614, 1021.4688362051692, 1043.6868939318326, 17232.65534689274, 17743.256743256745, 18391.356302529348, 18405.631887362444, 18766.6246675063, 30994.0, 37834.62165378311, 39291.0, 42571.574284258, 42681.786591068085, 58993.11510327263, 59690.40309596848, 62303.0, 63112.053319201164, 64278.0, 7622.504537205064, 8428.4942903426, 8720.345974051845, 9034.819303614022, 9045.231155351868, 11602.883971160518, 12610.18033827835, 12928.418221179882, 12973.740525189254, 13718.314084295946, 11673.241239319417, 11949.2830430171, 11955.64133076009, 12134.029277657943, 12358.258504489759, 10615.840762388416, 10678.733031673959, 10736.141108711441, 10766.81565027862, 10837.620683276047, 12118.515259389525, 12211.938940305241, 12288.167152440376, 12398.5660501882, 12451.377431128589, 8902.376833621584, 9015.684451044182, 9040.728778136667, 9111.271098312252, 9390.389624674373, 11629.825552616549, 11633.59282425111, 11719.941400292944, 11895.226810257305, 12437.813432798695], "value": 9279.123133394705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.4618152738897, 1474.292339676955, 1515.6741300620365, 1641.5321633334502, 1768.8673349498783, 8545.572721363931, 9062.0, 9063.093690630934, 9342.346035777482, 9350.485723285217, 9116.954415227914, 9166.816663666723, 9193.0, 9227.815443691123, 9233.44599324041, 2105.589410065038, 2333.7666233376694, 2431.0, 2454.901803927841, 2463.3718401807605, 2439.731629520751, 2462.642916777066, 2463.273334366357, 2464.938376540592, 2471.3327401601555, 2401.651760494727, 2402.9639555406684, 2411.3127758588807, 2412.8793560322, 2456.3245107595376, 2332.346942856003, 2403.122860156048, 2407.277816655005, 2409.903603855844, 2416.2630397728685, 2442.535918175541, 2453.4847681986803, 2475.0, 2479.1446950801947, 2482.11884780902, 9272.07279272074, 9313.348065635408, 9396.389234699722, 9428.481433521154, 9433.76415589609, 5377.462253774591, 5515.034868897967, 5520.585956053312, 5523.171524271352, 5532.30846144232, 3445.776024558421, 3552.8045957472327, 3660.432632941872, 3689.1330537323706, 3710.2579484103017, 1235.0613533714443, 1245.2528482910272, 1246.962591122268, 1278.1117123599101, 1290.2516540406637, 12677.0, 12830.807537886845, 12862.292573908431, 12867.09930304879, 12892.677683057906, 4782.0, 4793.9041219176115, 4806.8077276909235, 4915.9508404916205, 4967.776450059756, 10752.892471075345, 10755.193360497837, 10759.0, 10764.56941722338, 10765.946170269099, 5425.647332923426, 5439.5376393006245, 5446.183072539151, 5456.7544460499375, 5460.208269800856, 4092.202020606013, 4400.867973960786, 4991.875203119951, 4997.650164488451, 5000.474950130184, 4084.9795751021647, 4142.431409884509, 4166.270902592034, 4217.608189297524, 4228.302330115558, 1312.4290933443983, 1341.597520743773, 1344.3143996561823, 1346.3268365817091, 1347.3802051056427, 896.6054935828345, 939.736873675372, 1000.4847503535685, 1004.8141093897652, 1005.943759053006, 6031.819045428644, 6044.576879618472, 6134.355892631299, 6149.354317796657, 6307.740682881127, 485.3472080052324, 487.2326086413912, 491.1846335083815, 495.62332627202863, 510.51246060012596, 4188.162367526507, 4277.165952639268, 4282.550819835311, 4367.192069467159, 4389.078293558325, 10994.505247263733, 11358.488868000959, 11359.0, 11359.545618175345, 11360.431978401211, 11264.380459074666, 11272.549098035986, 11347.319160850375, 11357.091432685365, 11390.145739069438, 7978.521288722695, 8291.253787159185, 8302.584870756438, 8303.626336814857, 8318.126596707258, 6154.815355539341, 6183.443490085734, 6204.968975155095, 6214.689265536796, 6275.968620157053, 10265.486725663537, 10490.160787136858, 10616.363018218932, 10665.253432259979, 10673.839892401775, 7487.775366739006, 9819.312648114563, 10512.316699414514, 10722.981316774894, 10742.086922611665, 8004.5597492138495, 8141.389395795458, 8142.633581488729, 8188.918110819054, 8194.09864914847, 7883.84232315362, 7997.8400431992195, 8047.0, 8255.958720206361, 8702.521361324934, 7457.701691932479, 7508.774736757906, 7604.2395760423515, 7707.34487568563, 7710.460267781202, 7549.0941087069905, 7582.54504729718, 7622.123455802654, 7628.313451789366, 7700.768976930701, 6732.528722989344, 6793.490488213502, 6806.693698783468, 6825.385715285648, 7047.436205103682, 5135.05001574695, 5152.510511501401, 5321.521063104339, 5344.625876188629, 5434.891302174014, 5404.918926216189, 5480.671159730429, 5497.642653227527, 5575.804846830341, 5680.829575112588], "value": 4701.102999539225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.0735148934473, 341.56450525579885, 348.46162678661466, 353.33220213795914, 357.80857241375867, 5116.462771409004, 5209.14049181885, 5238.842834714955, 5249.5012973767525, 5250.4487028861995, 5128.666636668614, 5190.948090519103, 5206.140986737193, 5219.425863155059, 5219.921701174486, 3860.575336712959, 4113.115680128764, 4122.402251673506, 4132.545420003812, 4144.48193975753, 3924.274009308273, 3991.9600803992025, 4002.299597570428, 4041.454403655513, 4096.242195193884, 4030.8186131624, 4051.5340735815316, 4056.1482088761395, 4064.4919385076864, 4083.9795801020955, 4017.4777278953547, 4086.979565102185, 4090.713650044498, 4102.856400025999, 4116.341385378325, 3440.9827950860335, 3472.826358682056, 3627.673509384168, 3646.908827279339, 3655.190680613087, 4996.450390457083, 4998.850034498971, 5000.749962501896, 5004.424491183524, 5006.347905191278, 4643.744594047326, 4655.557722016403, 4658.254679251304, 4659.184642687516, 4664.696794708333, 5206.219067139921, 5317.680939143625, 5340.839774806762, 5349.251104845286, 5351.0, 3999.7800120993334, 4014.3577027675724, 4016.9397459038137, 4030.8992275193064, 4043.433919251307, 5548.805791797267, 5552.5280351170195, 5568.3596386415675, 5571.275734154575, 5572.944270557283, 3769.4911186989407, 4009.8195581198916, 4064.9796751016056, 4069.9796501017304, 4126.463559737215, 4097.631213190827, 4098.0124639549795, 4116.094459218967, 4120.855770048094, 4138.0, 4671.346011558385, 4672.672912896132, 4680.262046702649, 4695.22528782747, 4701.623870090384, 5304.363476382781, 5437.130059190589, 5502.724863756876, 5503.504684578327, 5513.807016754395, 1397.9166146236748, 1411.2308791708545, 1411.9294035298194, 1417.5818133650598, 1418.7869371687266, 882.2589025218847, 924.2098006204733, 924.2421214604094, 939.4457270210609, 940.6707652321633, 4635.397398338195, 4638.234691275969, 4652.930206046912, 4657.208274593328, 4975.701457912537, 5324.760385782649, 5452.781888724486, 5472.452754724496, 5478.780848766084, 5490.0, 5131.0, 5139.612304677716, 5144.2283657450935, 5156.226566015052, 5175.948240517622, 2816.8732407041734, 2879.92800179993, 2902.9709702903124, 2911.8398488082935, 2912.766978641746, 5653.717314134276, 5654.886902262014, 5663.943360566342, 5669.773209071591, 5672.205891175238, 5610.354809196913, 5612.438756124355, 5637.379888212294, 5637.605367624309, 5658.688772117573, 5417.51242388187, 5652.74562644682, 5654.5193658538665, 5659.518940889988, 5687.260656114679, 5492.148716948879, 5497.532709719719, 5507.311586051744, 5508.283923089973, 5581.888362232814, 5161.98024155873, 5424.511793938406, 5461.1262198048125, 5469.617126801086, 5551.333839939233, 5648.406917273627, 5679.858003549944, 5713.400092990176, 5726.4273572642405, 5744.793593345445, 4035.7174997749876, 4048.2510735514024, 4050.270951228807, 4080.143169934347, 4080.510338759368, 5433.375161856279, 5463.9180412294645, 5526.41972592888, 5576.609637325349, 5631.239782629293, 5332.760025798771, 5345.866353341197, 5350.6254562180275, 5361.169018802092, 5412.621116521806, 5349.251104845247, 5379.1393377059485, 5381.381141168659, 5383.623146379872, 5423.9186412204635, 5043.949560504348, 5253.737313134252, 5271.051210782096, 5284.709340986283, 5291.788328466818, 5368.382635996911, 5383.5423988961375, 5419.729013549386, 5426.267453893832, 5438.673679579238, 5035.29505869186, 5113.488651134857, 5231.006108839309, 5237.450067742832, 5241.711705856214], "value": 4131.841079117769, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.1302284929453, 776.5690042026673, 788.1251810490355, 858.3347905373339, 913.2237598041663, 14896.393131202038, 16010.679786404266, 16059.116748578852, 16061.75907361389, 16142.596435089128, 15624.375024999015, 15736.0, 15769.132697701622, 15769.369225231007, 15771.21143942804, 669.4142625202948, 786.4966421490223, 822.4777266435797, 825.7110011495988, 831.5717405536154, 823.2426167925523, 826.3760860550276, 826.946248493849, 826.983460330793, 827.400134902194, 706.6537396675643, 875.7810547363159, 877.5656050255133, 878.3368556739653, 879.9912000880005, 721.3832173491668, 730.9780706578811, 849.851276026699, 871.7646235516438, 875.7197696737047, 632.5414074795782, 636.4431122767578, 636.6625688385163, 636.6912047656883, 636.7834936121694, 14018.158910465405, 14045.367958441895, 14081.084729492653, 14147.717045659132, 14162.0, 14636.926815365856, 14660.266986650624, 14746.0, 14841.183734894577, 14938.32777525014, 13313.26777027263, 13353.933230333787, 13402.798958015637, 13451.86548134516, 13523.661908452268, 4374.19077470669, 4408.184485870092, 4551.112533056055, 4553.339765733983, 4578.954210457886, 82572.17427825705, 83584.0, 83783.58108209481, 84530.15469845284, 84649.0, 10835.78328433427, 11754.588589399329, 11770.411479425995, 11885.28688278706, 11930.164888457724, 20233.494162646053, 21445.78554214438, 21481.0, 21560.78439215619, 21586.78413215879, 8760.51817150063, 8851.424657397378, 9016.368854180144, 9028.593713282919, 9494.810103797885, 4965.1807451770055, 5020.648554601216, 5045.571126454292, 5072.847814565569, 5117.334746482933, 3745.344564701221, 3864.9227015459533, 3878.4376265441915, 3886.8639597613947, 3922.0, 686.6806934775353, 689.7344522358928, 703.6552089476222, 705.1256442011868, 708.9503734738622, 683.6718375179942, 695.0408436357794, 699.7620808924888, 745.5861996591943, 752.657540818937, 9465.290103242285, 9471.526423678788, 9574.760630984141, 10017.141686282148, 10608.41653709038, 684.4708209693373, 713.4149997002512, 715.1596873673413, 715.9309595269675, 734.353768683555, 4573.748443835621, 4768.785404656799, 4801.855944321676, 4825.697061793297, 4836.903261934812, 68972.65513672499, 70181.0, 70202.64898675474, 99471.0, 111073.44463277631, 63131.0, 75598.62200688961, 109274.45362773135, 111322.0, 113239.43380283046, 93933.5303323479, 98519.50740246396, 98965.50517247367, 99435.50282248542, 103275.0, 9052.456852588866, 9300.488473134043, 9407.905920940702, 9408.153266206074, 9557.61769529211, 55111.371746066645, 56465.717671413026, 57515.7124214393, 57524.0, 57825.0, 79199.0, 82172.58913705393, 84868.0, 84955.0, 89404.55297723469, 12015.45930433115, 12441.0, 12497.437615307152, 12533.686657833263, 12765.808512872129, 14137.43450261978, 14285.64285892861, 14320.928395357956, 14360.497382591559, 14585.270736463346, 12872.098953073195, 13030.218186908816, 13072.346382681018, 13264.403101860633, 13341.799873001719, 12442.81335779946, 12520.436580353724, 12535.749285014066, 12537.435815388148, 12575.87424125747, 11865.0, 12260.26438413698, 12516.687082823002, 12744.6813829655, 12852.0, 10779.622713205, 11308.773824523629, 11379.829302560634, 11399.658010259705, 11639.76720465603, 10849.403282819521, 11390.37352945596, 11529.654110376701, 11732.765344692887, 11752.941235293769], "value": 7677.3509255977115, "unit": "score"}], "name": "dromaeo_css", "value": 7326.174942059625, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 110.0, 107.0, 113.0, 112.0, 111.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 118.0, 183.0, 122.0, 119.0, 140.0, 121.0, 163.0, 117.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 159.0, 162.0, 159.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 108.0, 75.0, 75.0, 75.0, 74.0, 100.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 124.0, 90.0, 85.0, 85.0, 115.0, 85.0, 85.0, 122.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 51.0, 54.0, 51.0, 50.0, 52.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 61.0, 61.0, 61.0, 63.0, 65.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 82.0, 79.0, 90.0, 77.0, 83.0, 83.0, 80.0, 78.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 141.0, 125.0, 134.0, 121.0, 135.0, 122.0, 142.0, 132.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 163.0, 171.0, 167.0, 165.0, 164.0, 163.0, 167.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 62.0, 64.0, 73.0, 63.0, 64.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1496.6000000000001, "alertThreshold": 2.0}]} 01:17:25 INFO - Return code: 0 01:17:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:17:25 INFO - # TBPL SUCCESS # 01:17:25 INFO - Running post-action listener: _resource_record_post_action 01:17:25 INFO - [mozharness: 2016-08-19 08:17:25.528660Z] Finished run-tests step (success) 01:17:25 INFO - Running post-run listener: _resource_record_post_run 01:17:25 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 86016; Write bytes: 409042944; Read time: 140; Write time: 313844 01:17:25 INFO - TinderboxPrint: CPU usage
13.0% 01:17:25 INFO - TinderboxPrint: I/O read bytes / time
86,016 / 140 01:17:25 INFO - TinderboxPrint: I/O write bytes / time
409,042,944 / 313,844 01:17:25 INFO - TinderboxPrint: CPU idle
8,277.4 (87.0%) 01:17:25 INFO - TinderboxPrint: CPU user
1,193.2 (12.5%) 01:17:25 INFO - TinderboxPrint: Swap in / out
0 / 0 01:17:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118099968; Read time: 0; Write time: 98000 01:17:25 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 81920; Write bytes: 290471936; Read time: 128; Write time: 215840 01:17:26 INFO - Running post-run listener: _upload_blobber_files 01:17:26 INFO - Blob upload gear active. 01:17:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:17:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:17:26 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'] 01:17:26 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 01:17:26 INFO - (blobuploader) - INFO - Open directory for files ... 01:17:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:17:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:17:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:27 INFO - (blobuploader) - INFO - Done attempting. 01:17:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:17:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:17:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:28 INFO - (blobuploader) - INFO - Done attempting. 01:17:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:17:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:17:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:31 INFO - (blobuploader) - INFO - Done attempting. 01:17:31 INFO - (blobuploader) - INFO - Iteration through files over. 01:17:31 INFO - Return code: 0 01:17:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:17:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:17:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94189041c6e395dafa57292b1e466da7110fbc2ee5236da0c1a6e1d5ab644d075bd5910af4dae0fcd6aae4339226a4b34920bdc05612d94500f12405bbce336f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/368c5f2a4d9443a396dbbdba130c18a4aeb391b7c59cbea269a9442265daab2982e9edfafc8e7c3a1278c55fb8316702d89baa50357623497ce5e4c96ce60e8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771cf5e9f1316ee99b812cbe4c073f3a4934c41f149e78ab2f49bbf33ccd2e55a208dfc60a6df0885baa098d932ebe4818ec5307b6d0607bf469a22d79bc0303"} 01:17:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:17:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:17:31 INFO - Contents: 01:17:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94189041c6e395dafa57292b1e466da7110fbc2ee5236da0c1a6e1d5ab644d075bd5910af4dae0fcd6aae4339226a4b34920bdc05612d94500f12405bbce336f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/368c5f2a4d9443a396dbbdba130c18a4aeb391b7c59cbea269a9442265daab2982e9edfafc8e7c3a1278c55fb8316702d89baa50357623497ce5e4c96ce60e8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771cf5e9f1316ee99b812cbe4c073f3a4934c41f149e78ab2f49bbf33ccd2e55a208dfc60a6df0885baa098d932ebe4818ec5307b6d0607bf469a22d79bc0303"} 01:17:31 INFO - Running post-run listener: copy_logs_to_upload_dir 01:17:31 INFO - Copying logs to upload dir... 01:17:31 INFO - mkdir: /builds/slave/test/build/upload/logs 01:17:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.361762 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-19 01:17:31.655385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 01:17:31.659677) ========= 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=41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219 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/94189041c6e395dafa57292b1e466da7110fbc2ee5236da0c1a6e1d5ab644d075bd5910af4dae0fcd6aae4339226a4b34920bdc05612d94500f12405bbce336f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/368c5f2a4d9443a396dbbdba130c18a4aeb391b7c59cbea269a9442265daab2982e9edfafc8e7c3a1278c55fb8316702d89baa50357623497ce5e4c96ce60e8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771cf5e9f1316ee99b812cbe4c073f3a4934c41f149e78ab2f49bbf33ccd2e55a208dfc60a6df0885baa098d932ebe4818ec5307b6d0607bf469a22d79bc0303"} build_url:https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/KSx6GVp9R6O-lHVJOxWgxA/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/94189041c6e395dafa57292b1e466da7110fbc2ee5236da0c1a6e1d5ab644d075bd5910af4dae0fcd6aae4339226a4b34920bdc05612d94500f12405bbce336f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/368c5f2a4d9443a396dbbdba130c18a4aeb391b7c59cbea269a9442265daab2982e9edfafc8e7c3a1278c55fb8316702d89baa50357623497ce5e4c96ce60e8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/771cf5e9f1316ee99b812cbe4c073f3a4934c41f149e78ab2f49bbf33ccd2e55a208dfc60a6df0885baa098d932ebe4818ec5307b6d0607bf469a22d79bc0303"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 01:17:31.688286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 01:17:31.688893) ========= 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=41bf3e9aed84707956354da8000001c5-1471593020.46086-241496219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 01:17:31.772719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 01:17:31.773106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 01:17:31.773424) ========= ========= Total master_lag: 0.21 =========