builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1470350054.36 results: success (0) buildid: 20160804113003 builduid: 0aa2e0d1298746cfaa56e8843776ed27 revision: d912055f8e8ad75d189bd480017fdb5a33ee4d7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.356291) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.356760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.357289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.399010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.399348) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 15:34:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.9M=0.001s 2016-08-04 15:34:14 (19.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.536698) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.537428) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022809 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.639048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:14.639441) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d912055f8e8ad75d189bd480017fdb5a33ee4d7e --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 d912055f8e8ad75d189bd480017fdb5a33ee4d7e --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=edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 15:34:14,951 truncating revision to first 12 chars 2016-08-04 15:34:14,951 Setting DEBUG logging. 2016-08-04 15:34:14,951 attempt 1/10 2016-08-04 15:34:14,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d912055f8e8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 15:34:15,296 unpacking tar archive at: fx-team-d912055f8e8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723256 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:15.381755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:15.382400) ========= script_repo_revision: d912055f8e8ad75d189bd480017fdb5a33ee4d7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:15.383035) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:15.383350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 15:34:15.394845) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-04 15:34:15.395441) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:34:15 INFO - MultiFileLogger online at 20160804 15:34:15 in /builds/slave/test 15:34:15 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 15:34:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:34:15 INFO - {'append_to_log': False, 15:34:15 INFO - 'base_work_dir': '/builds/slave/test', 15:34:15 INFO - 'blob_upload_branch': 'Fx-Team', 15:34:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:34:15 INFO - 'branch': 'Fx-Team', 15:34:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:34:15 INFO - 'config_files': ('talos/linux_config.py',), 15:34:15 INFO - 'default_actions': ('clobber', 15:34:15 INFO - 'read-buildbot-config', 15:34:15 INFO - 'download-and-extract', 15:34:15 INFO - 'populate-webroot', 15:34:15 INFO - 'create-virtualenv', 15:34:15 INFO - 'install', 15:34:15 INFO - 'run-tests'), 15:34:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:34:15 INFO - 'download_minidump_stackwalk': True, 15:34:15 INFO - 'download_symbols': 'ondemand', 15:34:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:34:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:34:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:34:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:34:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:34:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:34:15 INFO - 'installer_path': 'installer.exe', 15:34:15 INFO - 'log_level': 'info', 15:34:15 INFO - 'log_name': 'talos', 15:34:15 INFO - 'log_to_console': True, 15:34:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:34:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:34:15 INFO - 'opt_config_files': (), 15:34:15 INFO - 'pip_index': False, 15:34:15 INFO - 'sps_profile': False, 15:34:15 INFO - 'sps_profile_interval': 0, 15:34:15 INFO - 'suite': 'dromaeojs', 15:34:15 INFO - 'system_bits': '32', 15:34:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:34:15 INFO - 'title': 'talos-linux64-ix-033', 15:34:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:34:15 INFO - 'use_talos_json': True, 15:34:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:34:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:34:15 INFO - 'work_dir': 'build'} 15:34:15 INFO - [mozharness: 2016-08-04 22:34:15.794482Z] Running clobber step. 15:34:15 INFO - Running pre-action listener: _resource_record_pre_action 15:34:15 INFO - Running main action method: clobber 15:34:15 INFO - rmtree: /builds/slave/test/build 15:34:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:16 INFO - Running post-action listener: _resource_record_post_action 15:34:16 INFO - [mozharness: 2016-08-04 22:34:16.763240Z] Finished clobber step (success) 15:34:16 INFO - [mozharness: 2016-08-04 22:34:16.763342Z] Running read-buildbot-config step. 15:34:16 INFO - Running pre-action listener: _resource_record_pre_action 15:34:16 INFO - Running main action method: read_buildbot_config 15:34:16 INFO - Using buildbot properties: 15:34:16 INFO - { 15:34:16 INFO - "project": "", 15:34:16 INFO - "product": "firefox", 15:34:16 INFO - "script_repo_revision": "production", 15:34:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:34:16 INFO - "repository": "", 15:34:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:34:16 INFO - "buildid": "20160804113003", 15:34:16 INFO - "pgo_build": "True", 15:34:16 INFO - "basedir": "/builds/slave/test", 15:34:16 INFO - "buildnumber": 954, 15:34:16 INFO - "slavename": "talos-linux64-ix-033", 15:34:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:34:16 INFO - "platform": "ubuntu64_hw", 15:34:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:34:16 INFO - "branch": "fx-team", 15:34:16 INFO - "repo_path": "integration/fx-team", 15:34:16 INFO - "revision": "d912055f8e8ad75d189bd480017fdb5a33ee4d7e", 15:34:16 INFO - "stage_platform": "linux64-pgo", 15:34:16 INFO - "builduid": "0aa2e0d1298746cfaa56e8843776ed27", 15:34:16 INFO - "slavebuilddir": "test" 15:34:16 INFO - } 15:34:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:34:16 INFO - Running post-action listener: _resource_record_post_action 15:34:16 INFO - [mozharness: 2016-08-04 22:34:16.765778Z] Finished read-buildbot-config step (success) 15:34:16 INFO - [mozharness: 2016-08-04 22:34:16.765866Z] Running download-and-extract step. 15:34:16 INFO - Running pre-action listener: _resource_record_pre_action 15:34:16 INFO - Running main action method: download_and_extract 15:34:16 INFO - mkdir: /builds/slave/test/build/tests 15:34: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')]} 15:34:16 INFO - trying https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:34:16 INFO - Downloading https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:17 INFO - Downloaded 1361 bytes. 15:34:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:34:17 INFO - Using the following test package requirements: 15:34:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:34:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:34:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'jsshell-linux-x86_64.zip'], 15:34:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:34:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:34:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:34:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:34:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:34:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:34:17 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')]} 15:34:17 INFO - trying https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:34:17 INFO - Downloading https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:18 INFO - Downloaded 21819995 bytes. 15:34:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:34:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:34:20 INFO - Return code: 0 15:34:20 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 15:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:20 INFO - trying https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:34:20 INFO - Downloading https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:21 INFO - Downloaded 21819995 bytes. 15:34:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:34:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:34:22 INFO - Return code: 0 15:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:22 INFO - trying https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:34:22 INFO - Downloading https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:23 INFO - Downloaded 14413723 bytes. 15:34:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:34:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:34:23 INFO - Return code: 0 15:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:23 INFO - trying https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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 15:34:24 INFO - Downloaded 59395626 bytes. 15:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:34:24 INFO - mkdir: /builds/slave/test/properties 15:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:24 INFO - Contents: 15:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:34:25 INFO - Running post-action listener: _resource_record_post_action 15:34:25 INFO - Running post-action listener: set_extra_try_arguments 15:34:25 INFO - [mozharness: 2016-08-04 22:34:25.448514Z] Finished download-and-extract step (success) 15:34:25 INFO - [mozharness: 2016-08-04 22:34:25.448749Z] Running populate-webroot step. 15:34:25 INFO - Running pre-action listener: _resource_record_pre_action 15:34:25 INFO - Running main action method: populate_webroot 15:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:34:25 INFO - '--tppagecycles', 15:34:25 INFO - '7'], 15:34:25 INFO - 'tests': ['tsvgm']}}, 15:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:34:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['damp', 'tps']}, 15:34:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'tests': ['damp', 'tps']}, 15:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['dromaeo_dom']}, 15:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['basic_compositor_video']}, 15:34:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tsvgx', 15:34:25 INFO - 'tsvgr_opacity', 15:34:25 INFO - 'tart', 15:34:25 INFO - 'tscrollx', 15:34:25 INFO - 'cart']}, 15:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:34:25 INFO - 'tsvgr_opacity', 15:34:25 INFO - 'tart', 15:34:25 INFO - 'tscrollx', 15:34:25 INFO - 'cart']}, 15:34:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tp5o']}, 15:34:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'tests': ['tp5o']}, 15:34:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s', 15:34:25 INFO - '--xperf_path', 15:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:25 INFO - 'tests': ['tp5n']}, 15:34:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--xperf_path', 15:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:25 INFO - 'tests': ['tp5n']}}, 15:34:25 INFO - 'talos.zip': {'path': '', 15:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:34:25 INFO - Running post-action listener: _resource_record_post_action 15:34:25 INFO - [mozharness: 2016-08-04 22:34:25.465010Z] Finished populate-webroot step (success) 15:34:25 INFO - [mozharness: 2016-08-04 22:34:25.465099Z] Running create-virtualenv step. 15:34:25 INFO - Running pre-action listener: _resource_record_pre_action 15:34:25 INFO - Running main action method: create_virtualenv 15:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:25 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 15:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:25 INFO - Using real prefix '/usr' 15:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:28 INFO - Installing pip.................done. 15:34:28 INFO - Return code: 0 15:34:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:28 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 15:34:28 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 15:34:28 INFO - Using env: {'DISPLAY': ':0', 15:34:28 INFO - 'HOME': '/home/cltbld', 15:34:28 INFO - 'LANG': 'en_US.UTF-8', 15:34:28 INFO - 'LANGUAGE': 'en_US:en', 15:34:28 INFO - 'LOGNAME': 'cltbld', 15:34:28 INFO - 'MAIL': '/var/mail/cltbld', 15:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:28 INFO - 'MOZ_NO_REMOTE': '1', 15:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:28 INFO - 'NO_EM_RESTART': '1', 15:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:28 INFO - 'PWD': '/builds/slave/test', 15:34:28 INFO - 'SHELL': '/bin/bash', 15:34:28 INFO - 'SHLVL': '1', 15:34:28 INFO - 'TERM': 'linux', 15:34:28 INFO - 'TMOUT': '86400', 15:34:28 INFO - 'USER': 'cltbld', 15:34:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:28 INFO - '_': '/tools/buildbot/bin/python'} 15:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:28 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 15:34:28 INFO - Cleaning up... 15:34:28 INFO - Return code: 0 15:34:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:28 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 15:34:28 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 15:34:28 INFO - Using env: {'DISPLAY': ':0', 15:34:28 INFO - 'HOME': '/home/cltbld', 15:34:28 INFO - 'LANG': 'en_US.UTF-8', 15:34:28 INFO - 'LANGUAGE': 'en_US:en', 15:34:28 INFO - 'LOGNAME': 'cltbld', 15:34:28 INFO - 'MAIL': '/var/mail/cltbld', 15:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:28 INFO - 'MOZ_NO_REMOTE': '1', 15:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:28 INFO - 'NO_EM_RESTART': '1', 15:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:28 INFO - 'PWD': '/builds/slave/test', 15:34:28 INFO - 'SHELL': '/bin/bash', 15:34:28 INFO - 'SHLVL': '1', 15:34:28 INFO - 'TERM': 'linux', 15:34:28 INFO - 'TMOUT': '86400', 15:34:28 INFO - 'USER': 'cltbld', 15:34:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:28 INFO - '_': '/tools/buildbot/bin/python'} 15:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:28 INFO - Downloading/unpacking psutil>=3.1.1 15:34:28 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 15:34:28 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 15:34:28 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 15:34:28 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 15:34:28 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 15:34:28 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 15:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:30 INFO - Installing collected packages: psutil 15:34:30 INFO - Running setup.py install for psutil 15:34:30 INFO - building 'psutil._psutil_linux' extension 15:34:30 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 15:34:30 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 15:34:30 INFO - building 'psutil._psutil_posix' extension 15:34:30 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 15:34:31 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 15:34:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:31 INFO - Successfully installed psutil 15:34:31 INFO - Cleaning up... 15:34:31 INFO - Return code: 0 15:34:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:34:31 INFO - Using env: {'DISPLAY': ':0', 15:34:31 INFO - 'HOME': '/home/cltbld', 15:34:31 INFO - 'LANG': 'en_US.UTF-8', 15:34:31 INFO - 'LANGUAGE': 'en_US:en', 15:34:31 INFO - 'LOGNAME': 'cltbld', 15:34:31 INFO - 'MAIL': '/var/mail/cltbld', 15:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:31 INFO - 'MOZ_NO_REMOTE': '1', 15:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:31 INFO - 'NO_EM_RESTART': '1', 15:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:31 INFO - 'PWD': '/builds/slave/test', 15:34:31 INFO - 'SHELL': '/bin/bash', 15:34:31 INFO - 'SHLVL': '1', 15:34:31 INFO - 'TERM': 'linux', 15:34:31 INFO - 'TMOUT': '86400', 15:34:31 INFO - 'USER': 'cltbld', 15:34:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:31 INFO - '_': '/tools/buildbot/bin/python'} 15:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:34:31 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 15:34:31 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 15:34:31 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 15:34:31 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 15:34:31 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 15:34:31 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 15:34:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:34:33 INFO - Installing collected packages: mozsystemmonitor 15:34:33 INFO - Running setup.py install for mozsystemmonitor 15:34:33 INFO - Successfully installed mozsystemmonitor 15:34:33 INFO - Cleaning up... 15:34:33 INFO - Return code: 0 15:34:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:34:33 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')]} 15:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:33 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')]} 15:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:33 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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:33 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 15:34:33 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 15:34:33 INFO - Using env: {'DISPLAY': ':0', 15:34:33 INFO - 'HOME': '/home/cltbld', 15:34:33 INFO - 'LANG': 'en_US.UTF-8', 15:34:33 INFO - 'LANGUAGE': 'en_US:en', 15:34:33 INFO - 'LOGNAME': 'cltbld', 15:34:33 INFO - 'MAIL': '/var/mail/cltbld', 15:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:33 INFO - 'MOZ_NO_REMOTE': '1', 15:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:33 INFO - 'NO_EM_RESTART': '1', 15:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:33 INFO - 'PWD': '/builds/slave/test', 15:34:33 INFO - 'SHELL': '/bin/bash', 15:34:33 INFO - 'SHLVL': '1', 15:34:33 INFO - 'TERM': 'linux', 15:34:33 INFO - 'TMOUT': '86400', 15:34:33 INFO - 'USER': 'cltbld', 15:34:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:33 INFO - '_': '/tools/buildbot/bin/python'} 15:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:33 INFO - Downloading/unpacking jsonschema==2.5.1 15:34:33 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 15:34:33 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 15:34:33 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 15:34:33 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 15:34:33 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 15:34:33 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 15:34:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:34:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:34:35 INFO - warning: no files found matching '*.txt' 15:34:35 INFO - no previously-included directories found matching 'build' 15:34:35 INFO - no previously-included directories found matching 'dist' 15:34:35 INFO - no previously-included directories found matching '.git*' 15:34:35 INFO - Installing collected packages: jsonschema, functools32 15:34:35 INFO - Running setup.py install for functools32 15:34:35 INFO - warning: no files found matching '*.txt' 15:34:35 INFO - no previously-included directories found matching 'build' 15:34:35 INFO - no previously-included directories found matching 'dist' 15:34:35 INFO - no previously-included directories found matching '.git*' 15:34:35 INFO - Successfully installed jsonschema functools32 15:34:35 INFO - Cleaning up... 15:34:36 INFO - Return code: 0 15:34:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:34:36 INFO - Using env: {'DISPLAY': ':0', 15:34:36 INFO - 'HOME': '/home/cltbld', 15:34:36 INFO - 'LANG': 'en_US.UTF-8', 15:34:36 INFO - 'LANGUAGE': 'en_US:en', 15:34:36 INFO - 'LOGNAME': 'cltbld', 15:34:36 INFO - 'MAIL': '/var/mail/cltbld', 15:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:36 INFO - 'MOZ_NO_REMOTE': '1', 15:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:36 INFO - 'NO_EM_RESTART': '1', 15:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:36 INFO - 'PWD': '/builds/slave/test', 15:34:36 INFO - 'SHELL': '/bin/bash', 15:34:36 INFO - 'SHLVL': '1', 15:34:36 INFO - 'TERM': 'linux', 15:34:36 INFO - 'TMOUT': '86400', 15:34:36 INFO - 'USER': 'cltbld', 15:34:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:36 INFO - '_': '/tools/buildbot/bin/python'} 15:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:34:36 INFO - Cleaning up... 15:34:36 INFO - Return code: 0 15:34:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:34:36 INFO - Using env: {'DISPLAY': ':0', 15:34:36 INFO - 'HOME': '/home/cltbld', 15:34:36 INFO - 'LANG': 'en_US.UTF-8', 15:34:36 INFO - 'LANGUAGE': 'en_US:en', 15:34:36 INFO - 'LOGNAME': 'cltbld', 15:34:36 INFO - 'MAIL': '/var/mail/cltbld', 15:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:36 INFO - 'MOZ_NO_REMOTE': '1', 15:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:36 INFO - 'NO_EM_RESTART': '1', 15:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:36 INFO - 'PWD': '/builds/slave/test', 15:34:36 INFO - 'SHELL': '/bin/bash', 15:34:36 INFO - 'SHLVL': '1', 15:34:36 INFO - 'TERM': 'linux', 15:34:36 INFO - 'TMOUT': '86400', 15:34:36 INFO - 'USER': 'cltbld', 15:34:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:36 INFO - '_': '/tools/buildbot/bin/python'} 15:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:34:36 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 15:34:36 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 15:34:36 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 15:34:36 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 15:34:36 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 15:34:36 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 15:34:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:39 INFO - Downloading docopt-0.6.1.tar.gz 15:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:39 INFO - Running setup.py install for blobuploader 15:34:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:39 INFO - Running setup.py install for requests 15:34:39 INFO - Running setup.py install for docopt 15:34:39 INFO - Successfully installed blobuploader requests docopt 15:34:39 INFO - Cleaning up... 15:34:39 INFO - Return code: 0 15:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:39 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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:39 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 15:34:39 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 15:34:39 INFO - Using env: {'DISPLAY': ':0', 15:34:39 INFO - 'HOME': '/home/cltbld', 15:34:39 INFO - 'LANG': 'en_US.UTF-8', 15:34:39 INFO - 'LANGUAGE': 'en_US:en', 15:34:39 INFO - 'LOGNAME': 'cltbld', 15:34:39 INFO - 'MAIL': '/var/mail/cltbld', 15:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:39 INFO - 'MOZ_NO_REMOTE': '1', 15:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:39 INFO - 'NO_EM_RESTART': '1', 15:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:39 INFO - 'PWD': '/builds/slave/test', 15:34:39 INFO - 'SHELL': '/bin/bash', 15:34:39 INFO - 'SHLVL': '1', 15:34:39 INFO - 'TERM': 'linux', 15:34:39 INFO - 'TMOUT': '86400', 15:34:39 INFO - 'USER': 'cltbld', 15:34:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:39 INFO - '_': '/tools/buildbot/bin/python'} 15:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:39 INFO - Running setup.py (path:/tmp/pip-U1Pcej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:40 INFO - Running setup.py (path:/tmp/pip-O66YFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:40 INFO - Running setup.py (path:/tmp/pip-bL_ty3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:40 INFO - Running setup.py (path:/tmp/pip-DG_OEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:40 INFO - Running setup.py (path:/tmp/pip-DcdrCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:40 INFO - Running setup.py (path:/tmp/pip-Fe6aK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:40 INFO - Running setup.py (path:/tmp/pip-7B1RZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:40 INFO - Running setup.py (path:/tmp/pip-2RZSmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:40 INFO - Running setup.py (path:/tmp/pip-mOKDdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:40 INFO - Running setup.py (path:/tmp/pip-l5lPV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:40 INFO - Running setup.py (path:/tmp/pip-iRAk2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:40 INFO - Running setup.py (path:/tmp/pip-u5kiHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:40 INFO - Running setup.py (path:/tmp/pip-jxwiMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:40 INFO - Running setup.py (path:/tmp/pip-WsG28j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:40 INFO - Running setup.py (path:/tmp/pip-lHRgoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:41 INFO - Running setup.py (path:/tmp/pip-H6Gj0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:41 INFO - Running setup.py (path:/tmp/pip-O0EXpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:41 INFO - Running setup.py install for manifestparser 15:34:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Running setup.py install for mozcrash 15:34:41 INFO - Running setup.py install for mozdebug 15:34:41 INFO - Running setup.py install for mozdevice 15:34:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Running setup.py install for mozfile 15:34:41 INFO - Running setup.py install for mozhttpd 15:34:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Running setup.py install for mozinfo 15:34:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Running setup.py install for mozInstall 15:34:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozleak 15:34:42 INFO - Running setup.py install for mozlog 15:34:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for moznetwork 15:34:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozprocess 15:34:42 INFO - Running setup.py install for mozprofile 15:34:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozrunner 15:34:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozscreenshot 15:34:42 INFO - Running setup.py install for moztest 15:34:42 INFO - Running setup.py install for mozversion 15:34:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:42 INFO - Cleaning up... 15:34:42 INFO - Return code: 0 15:34:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:42 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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:42 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 15:34:42 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 15:34:42 INFO - Using env: {'DISPLAY': ':0', 15:34:42 INFO - 'HOME': '/home/cltbld', 15:34:42 INFO - 'LANG': 'en_US.UTF-8', 15:34:42 INFO - 'LANGUAGE': 'en_US:en', 15:34:42 INFO - 'LOGNAME': 'cltbld', 15:34:42 INFO - 'MAIL': '/var/mail/cltbld', 15:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:42 INFO - 'MOZ_NO_REMOTE': '1', 15:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:42 INFO - 'NO_EM_RESTART': '1', 15:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:42 INFO - 'PWD': '/builds/slave/test', 15:34:42 INFO - 'SHELL': '/bin/bash', 15:34:42 INFO - 'SHLVL': '1', 15:34:42 INFO - 'TERM': 'linux', 15:34:42 INFO - 'TMOUT': '86400', 15:34:42 INFO - 'USER': 'cltbld', 15:34:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:42 INFO - '_': '/tools/buildbot/bin/python'} 15:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:43 INFO - Running setup.py (path:/tmp/pip-WXzz0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:43 INFO - Running setup.py (path:/tmp/pip-PbfvEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:43 INFO - Running setup.py (path:/tmp/pip-Vyy7n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:43 INFO - Running setup.py (path:/tmp/pip-g7Ka75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:43 INFO - Running setup.py (path:/tmp/pip-FsVKSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:43 INFO - Running setup.py (path:/tmp/pip-_gR5zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:43 INFO - Running setup.py (path:/tmp/pip-xGCjpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:43 INFO - Running setup.py (path:/tmp/pip-Xm7xY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:43 INFO - Running setup.py (path:/tmp/pip-r9BChe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:43 INFO - Running setup.py (path:/tmp/pip-51FnV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:43 INFO - Running setup.py (path:/tmp/pip-aHruh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:44 INFO - Running setup.py (path:/tmp/pip-d2qV2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:44 INFO - Running setup.py (path:/tmp/pip-XlTjXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:44 INFO - Running setup.py (path:/tmp/pip-IY_3zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:44 INFO - Running setup.py (path:/tmp/pip-WNv8uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:44 INFO - Running setup.py (path:/tmp/pip-5BZ7Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:44 INFO - Running setup.py (path:/tmp/pip-kjSKuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:46 INFO - Downloading blessings-1.6.tar.gz 15:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:46 INFO - Installing collected packages: blessings 15:34:46 INFO - Running setup.py install for blessings 15:34:46 INFO - Successfully installed blessings 15:34:46 INFO - Cleaning up... 15:34:46 INFO - Return code: 0 15:34:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:46 INFO - Reading from file tmpfile_stdout 15:34:46 INFO - Current package versions: 15:34:46 INFO - argparse == 1.2.1 15:34:46 INFO - blessings == 1.6 15:34:46 INFO - blobuploader == 1.2.4 15:34:46 INFO - docopt == 0.6.1 15:34:46 INFO - functools32 == 3.2.3-2 15:34:46 INFO - jsonschema == 2.5.1 15:34:46 INFO - manifestparser == 1.1 15:34:46 INFO - mozInstall == 1.12 15:34:46 INFO - mozcrash == 0.17 15:34:46 INFO - mozdebug == 0.1 15:34:46 INFO - mozdevice == 0.48 15:34:46 INFO - mozfile == 1.2 15:34:46 INFO - mozhttpd == 0.7 15:34:46 INFO - mozinfo == 0.9 15:34:46 INFO - mozleak == 0.1 15:34:46 INFO - mozlog == 3.3 15:34:46 INFO - moznetwork == 0.27 15:34:46 INFO - mozprocess == 0.23 15:34:46 INFO - mozprofile == 0.28 15:34:46 INFO - mozrunner == 6.12 15:34:46 INFO - mozscreenshot == 0.1 15:34:46 INFO - mozsystemmonitor == 0.3 15:34:46 INFO - moztest == 0.7 15:34:46 INFO - mozversion == 1.4 15:34:46 INFO - psutil == 3.1.1 15:34:46 INFO - requests == 1.2.3 15:34:46 INFO - wsgiref == 0.1.2 15:34:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:46 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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:46 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 15:34:46 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 15:34:46 INFO - Using env: {'DISPLAY': ':0', 15:34:46 INFO - 'HOME': '/home/cltbld', 15:34:46 INFO - 'LANG': 'en_US.UTF-8', 15:34:46 INFO - 'LANGUAGE': 'en_US:en', 15:34:46 INFO - 'LOGNAME': 'cltbld', 15:34:46 INFO - 'MAIL': '/var/mail/cltbld', 15:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:46 INFO - 'MOZ_NO_REMOTE': '1', 15:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:46 INFO - 'NO_EM_RESTART': '1', 15:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:46 INFO - 'PWD': '/builds/slave/test', 15:34:46 INFO - 'SHELL': '/bin/bash', 15:34:46 INFO - 'SHLVL': '1', 15:34:46 INFO - 'TERM': 'linux', 15:34:46 INFO - 'TMOUT': '86400', 15:34:46 INFO - 'USER': 'cltbld', 15:34:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:46 INFO - '_': '/tools/buildbot/bin/python'} 15:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 INFO - Cleaning up... 15:34:47 INFO - Return code: 0 15:34:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34:47 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')]} 15:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:47 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')]} 15:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:47 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 0x174c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', '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 15:34:47 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 15:34:47 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 15:34:47 INFO - Using env: {'DISPLAY': ':0', 15:34:47 INFO - 'HOME': '/home/cltbld', 15:34:47 INFO - 'LANG': 'en_US.UTF-8', 15:34:47 INFO - 'LANGUAGE': 'en_US:en', 15:34:47 INFO - 'LOGNAME': 'cltbld', 15:34:47 INFO - 'MAIL': '/var/mail/cltbld', 15:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:47 INFO - 'MOZ_NO_REMOTE': '1', 15:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:47 INFO - 'NO_EM_RESTART': '1', 15:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:47 INFO - 'PWD': '/builds/slave/test', 15:34:47 INFO - 'SHELL': '/bin/bash', 15:34:47 INFO - 'SHLVL': '1', 15:34:47 INFO - 'TERM': 'linux', 15:34:47 INFO - 'TMOUT': '86400', 15:34:47 INFO - 'USER': 'cltbld', 15:34:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:47 INFO - '_': '/tools/buildbot/bin/python'} 15:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:47 INFO - Cleaning up... 15:34:47 INFO - Return code: 0 15:34:47 INFO - Running post-action listener: _resource_record_post_action 15:34:47 INFO - Running post-action listener: _start_resource_monitoring 15:34:47 INFO - Starting resource monitoring. 15:34:47 INFO - [mozharness: 2016-08-04 22:34:47.298971Z] Finished create-virtualenv step (success) 15:34:47 INFO - [mozharness: 2016-08-04 22:34:47.299408Z] Running install step. 15:34:47 INFO - Running pre-action listener: _resource_record_pre_action 15:34:47 INFO - Running main action method: install 15:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:47 INFO - Reading from file tmpfile_stdout 15:34:47 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:47 INFO - Reading from file tmpfile_stdout 15:34:47 INFO - Output received: 15:34:47 INFO - Usage: mozinstall [options] installer 15:34:47 INFO - Options: 15:34:47 INFO - -h, --help show this help message and exit 15:34:47 INFO - -d DEST, --destination=DEST 15:34:47 INFO - Directory to install application into. [default: 15:34:47 INFO - "/builds/slave/test"] 15:34:47 INFO - --app=APP Application being installed. [default: firefox] 15:34:47 INFO - mkdir: /builds/slave/test/build/application 15:34:47 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'] 15:34:47 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 15:35:04 INFO - Reading from file tmpfile_stdout 15:35:04 INFO - Output received: 15:35:04 INFO - /builds/slave/test/build/application/firefox/firefox 15:35:04 INFO - Running post-action listener: _resource_record_post_action 15:35:04 INFO - [mozharness: 2016-08-04 22:35:04.609567Z] Finished install step (success) 15:35:04 INFO - [mozharness: 2016-08-04 22:35:04.609828Z] Running run-tests step. 15:35:04 INFO - Running pre-action listener: _resource_record_pre_action 15:35:04 INFO - Running main action method: run_tests 15:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:04 INFO - Python 2.7.3 15:35:04 INFO - Return code: 0 15:35:04 INFO - grabbing minidump binary from tooltool 15:35:04 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')]} 15:35:04 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 0x1a0b3b0>, '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 0x1a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:04 INFO - Return code: 0 15:35:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:35:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:35:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:04 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/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:35:04 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/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 15:35:04 INFO - Using env: {'DISPLAY': ':0', 15:35:04 INFO - 'HOME': '/home/cltbld', 15:35:04 INFO - 'LANG': 'en_US.UTF-8', 15:35:04 INFO - 'LANGUAGE': 'en_US:en', 15:35:04 INFO - 'LOGNAME': 'cltbld', 15:35:04 INFO - 'MAIL': '/var/mail/cltbld', 15:35:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:04 INFO - 'MOZ_NO_REMOTE': '1', 15:35:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:04 INFO - 'NO_EM_RESTART': '1', 15:35:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:04 INFO - 'PWD': '/builds/slave/test', 15:35:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:04 INFO - 'SHELL': '/bin/bash', 15:35:04 INFO - 'SHLVL': '1', 15:35:04 INFO - 'TERM': 'linux', 15:35:04 INFO - 'TMOUT': '86400', 15:35:04 INFO - 'USER': 'cltbld', 15:35:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705', 15:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:04 INFO - '_': '/tools/buildbot/bin/python'} 15:35:04 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/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:35:04 INFO - mozversion application_buildid: 20160804113003 15:35:04 INFO - mozversion application_changeset: d912055f8e8ad75d189bd480017fdb5a33ee4d7e 15:35:04 INFO - mozversion application_display_name: Nightly 15:35:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:04 INFO - mozversion application_name: Firefox 15:35:04 INFO - mozversion application_remotingname: firefox 15:35:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:35:04 INFO - mozversion application_vendor: Mozilla 15:35:04 INFO - mozversion application_version: 51.0a1 15:35:04 INFO - mozversion platform_buildid: 20160804113003 15:35:04 INFO - mozversion platform_changeset: d912055f8e8ad75d189bd480017fdb5a33ee4d7e 15:35:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:35:04 INFO - mozversion platform_version: 51.0a1 15:35:04 INFO - using testdate: 1470350104 15:35:04 INFO - actual date: 1470350104 15:35:04 INFO - starting webserver on 'localhost:48291' 15:35:04 INFO - SUITE-START | Running 2 tests 15:35:04 INFO - TEST-START | dromaeo_css 15:35:04 INFO - operating with platform_type : linux_ 15:35:04 INFO - Initialising browser for dromaeo_css test... 15:35:04 INFO - TEST-INFO | started process 22626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUHve3/profile http://localhost:48291/getInfo.html) 15:35:09 INFO - PROCESS | 22626 | __metrics Screen width/height:1600/1200 15:35:09 INFO - PROCESS | 22626 | colorDepth:24 15:35:09 INFO - PROCESS | 22626 | Browser inner width/height: 1024/697 15:35:09 INFO - PROCESS | 22626 | __metrics 15:35:10 INFO - PROCESS | 22626 | 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" 15:35:10 INFO - PROCESS | 22626 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:10 INFO - PROCESS | 22626 | console.error: PushService: 15:35:10 INFO - PROCESS | 22626 | stateChangeProcessEnqueue: Error transitioning state 15:35:10 INFO - PROCESS | 22626 | UnknownError 15:35:11 INFO - TEST-INFO | 22626: exit 0 15:35:11 INFO - Browser initialized. 15:35:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:35:11 INFO - TEST-INFO | started process 22710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUHve3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:23 INFO - PROCESS | 22710 | RSS: Main: 155176960 15:35:23 INFO - PROCESS | 22710 | 15:36:14 INFO - PROCESS | 22710 | 1470350174835 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] 15:38:24 INFO - PROCESS | 22710 | Cycle 1(1): loaded http://localhost:48291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48291/tests/dromaeo/cssquery-ext.html) 15:38:25 INFO - PROCESS | 22710 | RSS: Main: 267018240 15:38:25 INFO - PROCESS | 22710 | 15:41:28 INFO - PROCESS | 22710 | Cycle 1(1): loaded http://localhost:48291/tests/dromaeo/cssquery-ext.html (next: http://localhost:48291/tests/dromaeo/cssquery-jquery.html) 15:41:28 INFO - PROCESS | 22710 | RSS: Main: 246202368 15:41:28 INFO - PROCESS | 22710 | 15:44:30 INFO - PROCESS | 22710 | Cycle 1(1): loaded http://localhost:48291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48291/tests/dromaeo/cssquery-mootools.html) 15:44:31 INFO - PROCESS | 22710 | RSS: Main: 183996416 15:44:31 INFO - PROCESS | 22710 | 15:47:33 INFO - PROCESS | 22710 | Cycle 1(1): loaded http://localhost:48291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48291/tests/dromaeo/cssquery-prototype.html) 15:47:33 INFO - PROCESS | 22710 | RSS: Main: 205348864 15:47:33 INFO - PROCESS | 22710 | 15:50:36 INFO - PROCESS | 22710 | Cycle 1(1): loaded http://localhost:48291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48291/tests/dromaeo/cssquery-yui.html) 15:50:37 INFO - PROCESS | 22710 | RSS: Main: 182538240 15:50:37 INFO - PROCESS | 22710 | 15:53:39 INFO - PROCESS | 22710 | Cycle 1(1): loaded http://localhost:48291/tests/dromaeo/cssquery-yui.html (next: http://localhost:48291/tests/dromaeo/cssquery-dojo.html) 15:53:40 INFO - PROCESS | 22710 | RSS: Main: 258895872 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | __start_tp_report 15:53:40 INFO - PROCESS | 22710 | _x_x_mozilla_page_load 15:53:40 INFO - PROCESS | 22710 | _x_x_mozilla_page_load_details 15:53:40 INFO - PROCESS | 22710 | |i|pagename|runs| 15:53:40 INFO - PROCESS | 22710 | |0;dojo.html;3081.2296925768574;3094.9071527854157;3096.071178646406;3115.9844200778994;3143.151349135733;5305.7877684892555;5318.813841515548;5367.946320536794;5378;5418.5665146788215;5304.310439642841;5373.382061062969;5402.648827826189;5444.047291723952;5445.019896418653;4812.037592481509;4908.631852611051;4912.926306105393;4919.040787046527;5075.061113693979;4975.378077740283;5004.199328107504;5012.248162775576;5027.723475208881;5027.798888044474;4779.976100119512;4841.685290456109;4948.653594248404;4952.727599981999;4956.950430495685;4848.22428411456;4861.805527778884;4877.804887804519;4940.851774446773;5017.34774479319;4877.975610121962;4907.190313598252;4913.803447862081;4939.8024079036795;4988.251762235657;5230.476952304777;5276;5332.520073193431;5378.058839703036;5441.863953401157;5712.942870571283;5758.395368486291;5808.361080281208;5809.215755872945;5815.273090863642;5829.154772557998;5843.795467158671;5844.678542680151;5847.941520584783;5848.766049358021;5266.183741520071;5354.4110147884485;5357.812476563302;5359.598030147677;5436.157395603648;5981.162637230791;5984.970075149684;5996.610220335664;5996.910046349309;5997.430244126801;5713.171590119409;5738.913916291259;5752.6836024019085;5755.65466072037;5760.53915686744;5579.2746942897165;5695.202671625976;5728.885422291614;5745.798897038583;5854.151148083589;5747.281589801275;5751.626144300607;5753.165790960371;5768.884622307614;5802.535797136304;5717.656940583578;5766.308043034863;5768.509676677446;5773.971130144407;5794.88410231793;4328.567143285646;4362.607365337135;4385.627221686129;4397.978010109929;4448.110377924363;3965.0682089708894;3977.5226972762875;4009.0578714002186;4010.5387880393546;4048.08917993455;5488.807891723771;5506.779728810883;5513.9448605513435;5519.751611177507;5559.11054231321;5573.944260557424;5747.023006088975;5791.507721843606;5812.593118481665;5830.125481177857;5506.862328441821;5510.779568817283;5519.586031047607;5519.586031047687;5568.1091025435735;5043.621728370387;5043.646944713908;5044.394672639307;5046.62150338726;5102.591792656579;5731.799387021518;5974.880502390015;6033.095035744674;6059.545534084873;6069;5815;5837.970810145922;5846.386129456346;5848.152017957457;5897.764089436375;6060.666663333559;6062.211912451353;6075.939240607538;6078.118672792332;6079.665618391031;5546.168074788814;5547.500724934614;5588.441155884379;5688.203651488878;5758.827235182951;5686.744096515584;5723.370429252862;5734.684592347294;5752.827415177551;5774.364819869895;5609.579281553982;5613.522850557748;5614.07367784311;5616.747246373841;5621.409751975983;5372.328458942632;5568.6658800472105;5570.693611851225;5593.356763972195;5595;5596.944030559643;5599;5600.85997850057;5639.802606908738;5653.038983372754;5685.602007859576;5693.800716974886;5725.942740572707;5738;5749.626274292157;5383.892322153457;5390.110631745718;5450.400455949922;5529.032419326521;5542.946840100368 15:53:40 INFO - PROCESS | 22710 | |1;ext.html;566.1875209074977;599.9580029397941;603.2941458493565;613.8434699151716;617.9474744646704;32214.194645133855;44285.557144428545;44696.10607787842;44987;45413.31880021798;44677.77661111698;45080.774596127056;45099;45099.16657084144;45115.32327015098;8969.865452018224;9125.269978401746;9126.133017363372;9128.224100951395;9134.223590994774;8942.597583108743;9016.54917254138;9026.909730902673;9029.142231487998;9036.728898133033;9035.457872527637;9087.863682044775;9089.136532029479;9090.909090909105;9093.590788414538;9024.8646270306;9112.179903808623;9118.179363857285;9120.908790912139;9122.042185570486;8980.371374003822;9031.909680903173;9045.412048216911;9053.637854485813;9060.682876099305;42567.57432425667;42582.78708606468;42888.356674649905;42903.78548107271;42904;3646;3658.945115823238;3781;3886.5724770275247;4285.335772955197;33429.16427089342;33853.49219761706;34069.65930340714;34141.82929085364;34954.65045349565;4166.145940082276;4294.570542945712;4386.868393948187;4425.4894625265;4433.290673492258;348639;349549;349845;349984;354859;60672.39327606756;61189.38810611926;61353.38646613566;61400.38599614036;61422.38577614256;64581.35418645848;64604.67697661576;64718;64722.35277647257;64730.35269647243;17073.31706731717;17233.482995510156;17283.74074388885;17284.82715172832;17289;13357.666058348424;13415.329233538285;13424.127431716906;13428.530001449903;13430.93284533571;16281.348746050262;18235.45293641193;18300.908495457705;18354.174062167236;18426.723599146022;5755.280589926259;5935.1987481690285;5997.430244126801;6062.787802426894;6074.696265186723;699.810737201684;1069.668402795136;1072.5012869015789;1108.8170451875512;1119.4906317625462;32788.40962265285;33967.4904876427;33970.32059358799;36672.44991325132;37607.811960940024;1064.5635289531256;1136.2727854173336;1145.9427028648533;1175.3887978251262;1196.8144937534696;17211.56971075708;17672.646547068987;17966.191521381308;17982;18052.819471805113;541393;547064;548800;549840;553464;59608;59841.70079149664;59945;60107.39892601018;60190;1238.3746208164819;1289.4455384184891;1291.7029083310704;1323.4309247023873;1348.393223049612;30158.246043849078;33262.16844578905;34005;34151;37282.813585932985;58315;58856;59002;59033.40966590451;59071.1139332919;468228;469766;471045;471407;471575;29024.7097529022;29954.400911981204;30161.547576786805;30229;31860.5220921691;47251.52748472471;48807.511924880295;49267.50732492629;51178.48821511737;53814.46185538251;40709.389359159046;43423.782881086656;43850.561494384645;44029.55970440255;44780.55219447764;42772.572274276856;42899;43312.350314745934;44302.77848610736;44727.10545789131;41875.162496750505;42448.15103697847;42680.14639707251;42690.78654606707;43836.561634383244;35690;36237;37085.44371834479;37775.43336849895;39522;28949.42101158007;29673;29718.851405742833;29724.40551188921;29801 15:53:40 INFO - PROCESS | 22710 | |2;jquery.html;359.60443512136635;374.76577139287934;376.3658235872555;384.3734712418757;389.26040523006304;14739;18771.343002994898;18814.435566932996;19189.904050479727;20464.590708185828;18686.626267474643;20106.396808095746;20202.89898550509;20223.191072357087;20226.797732022675;5522.502974732283;5812.50593699534;5817.301923769132;5819.272590926134;5820.214271073393;5542.334919809608;5704.743286552094;5776.711164441782;5806.477417032466;5808.680522571257;5763.279590051244;5768.682722450264;5769.855753606152;5769.913451298234;5770.913436298459;5599.496045355897;5695.800646977356;5720.542356611461;5761.078227483625;5765.88468230633;5046.243063540498;5110.565601923841;5128.333316668846;5137.0496458154985;5139.640225184238;24292.514149717084;24508.142215022388;24695.135670251635;24800.627990580157;25007.62488562673;2210.6462965925534;2220.655798351258;2228;2949.8495586721197;3027.7880548361622;14511.782323265159;14622.707545849129;14994.62513437162;15039;15324.233788310652;1830.2770405689812;1870.2892900697784;1930.4112245765036;1948.7661480622273;1972.8717633353785;81498.59250703768;84517.15482845154;85321.57339213326;85521.99999999937;86633;10496.107830834311;10576.41829699374;10681.03870651645;10951.233413660968;10982.560697572168;14628.122312661275;14653;14653.12081275127;14658.63353416173;14659.633509162142;7564.319211270902;7687.769366919001;7741.574213418204;7943.44395892282;8128.63421146038;7057.823554411181;7078.929210707827;7094.574325540484;7264.346208841124;7310.268973102648;4381.079973205662;4392.099619578043;4498.460184777848;4564.1556312082375;4624.398828152319;1920.4238728381429;1945.5816999345209;1963.391348681913;1966.6754985427244;1981.9801801982085;839.3998291221806;923;980.3235767320526;993.7714325705128;1029.464678367245;19594.90202548978;20344.49138771513;20345.593088138154;20434;20439.591208175752;909.3816204980677;959.0122174160625;961.3078583419926;969.3892847506027;990.8166989107038;10737.83893241602;11279.288823150213;11356.659300221007;11390.088792896548;11454;421694;441472;487836;516112;520149;84091;89572.0649061398;93737.531312343;94542.52728736312;96002.7433615122;929.6049179098856;986.1913231150388;993.3344659078434;994.3741981859712;1005.8826170910274;17407.12964351752;17682.5579360517;17912;18061.458156255332;18348.541286467946;41847.790761046;43330.56669433265;43537.346939795294;44112.558874410846;45095.098098038514;55583.44416555944;57405.13892291536;59694.40305597062;59798.10302845374;60596.09105863504;8511.914880851113;8568.443051201652;8573.657053717781;8637.352198585257;8695.60869760875;12589.93705031469;13402.664933376744;13443.865561344652;13612.591622251348;13634.590962271148;11494.827577586175;11687.649370518899;11817.468213930222;11919.642410727693;12079.51681932713;11435.256708313933;11660.766784664429;12002.879971200176;12023.398830058288;12458.937705311415;11667.474963626488;11727.41362931833;11763.941180294043;12009.219400738924;12301.200421972542;7538.0954285483895;7632.1986191451315;7841.686332546634;8127.268545830903;9062.954685226532;11730.002949749367;11747.941260293986;11810.468528916392;11873.465694043962;11920.284782912706 15:53:40 INFO - PROCESS | 22710 | |3;mootools.html;1317.8813906748403;1452.2230606625453;1499.5426394949543;1608.5013645769811;1732.4369579886531;8321.62552685129;8730.432521886072;8753.606087726052;9085.909140908589;9097.181253687168;8825.33809964252;8993.190612844843;9030.819383612325;9041.683541076063;9048.411853229536;2347.6243800991847;2375.2517956843626;2375.3705268103968;2375.5011447596025;2377.239283429303;2306.8961896714686;2330.219376508863;2360.303710405426;2365.680633114525;2365.6924599802087;2290.0496294037953;2307.100230909938;2316.4672125411166;2330.5571941331177;2335.8364914455997;2245.2815099168274;2272.454610893382;2294.4608017115966;2294.542965217091;2314.340412982309;2277.7266727992746;2284.6116160252795;2285.645724912641;2290.931272061841;2291.7937385635373;8850.114988501162;8910.465372077697;9001.819963600692;9002.279817614575;9016.59425325862;5087.211482220262;5286.233496143076;5292.417834038252;5311.920321195185;5316.069687804657;3380.20565167188;3393.609734880471;3461.4807778833124;3462.1344663834043;3468.5837699475974;1073.6134991403167;1090.2741020326418;1091.3397394576325;1114.4873358255213;1132.8470656461354;12358.876411235862;12375.443105060294;12505.312207828565;12515.311657858905;12544.81182782259;4336.783160841946;4403.2734598791485;4501.774911254424;4505.617022553054;4594.0582180653555;9675.129238368581;9689.51552422376;9689.70930872075;9699.903000970042;9702.660406885867;5214.8957020860125;5221.503957124143;5224.399194092652;5224.425313215544;5230.764615592308;4268.893277668021;4778.976105119522;4893.363862697897;4902.338184345068;4912;3689.9077523062138;3761.5486141663177;3775.8300876460626;3848.0764616491842;3859.0352411897024;1104.2049724198564;1128.1651577832345;1135.5060548661359;1138.7608602193632;1149.350616901448;782.1865260129515;901.8906744704051;915.6207282216975;916.7799728065349;927.735595355334;5486.670799752028;5502.064649009678;5577.163425486128;5639.436056394327;5664.291963504562;968.6367612145445;979.2264111352094;980.8381617033252;1007.2848277722752;1007.6372505897871;3752.887413377603;3866.9613303867163;3900.941485877714;3931.6264954829244;3942.8817135485983;10813.513391897384;11170.832437513443;11187.944060279646;11204.551817927355;11212;10968.396738179477;11003.889961100447;11007.229493935347;11079.944600276947;11098.44507774608;7949.761507154794;8181.631826567819;8303.418760686694;8557.871631925525;8688.348373871859;5819.1018342821135;5835.94164058354;5941.494972927349;5994.130851026664;6097.908531371944;10465.68602941913;10506.527206275889;10508;10523.631672891412;10620.150387969099;10259.17926565858;10431.37411755297;10491.68524944253;10508.264421490423;10523.894761052292;7106.964465177848;7496.475246732894;7531.736389226351;7706.884396734165;7722.768316950501;8823.514706691194;8910.59902304385;8914;8914.465132092095;8916.86624700643;7598.430117741302;7688.231176882267;7822.804429889298;7910.248526389983;7946.562939038177;7420.443466739908;7476.925230747623;7477.327040566158;7562.319391254593;7598.20218877032;6633.1376920999965;6732.259451460238;6734.528582999143;6734.764283250062;6742.393184613212;4844.249141383091;4948.8762780930765;4974.9502504975935;5067.46791586878;5072.644914855925;4776.14029474684;4894.681845680019;4917.385326834145;4991.5258050485145;5028.874278143076 15:53:40 INFO - PROCESS | 22710 | |4;prototype.html;308.0880593443406;308.96755840636735;317.41753881627204;320.3608800443116;321.53377602476417;5244.632875698698;5271.683698978054;5282.392524859642;5286.603504737141;5296.496832800887;4934.654574179809;5003;5132.894598767748;5140.20326849338;5219.634625576211;4062.9436346549887;4068.471098757172;4086.3870419437176;4105.774182419966;4139.1100913303635;4054.3107671695884;4066.2311894325917;4092.4857802613074;4095.651869591088;4098.8360465581345;3805.4101614249835;3894.8636797712084;4044.231595996766;4055.2092341993325;4065.7560546367313;4040.0909795295825;4045.110075783323;4054.432379466877;4066.2680717470844;4069.4302797608357;3566.5898421681577;3577.928441431183;3585.731070169748;3586.1751797086554;3600.1539638185004;5009.348784657971;5086.353769812663;5108;5125.641205115643;5146.768395422215;4625.95374046262;4630;4640.303954406832;4652.604528615072;4653.092646933849;5419.295491586108;5422;5422.457754224585;5431.728413579305;5438.238646589481;3646.6353364663587;3825.4261860721112;3920.137569734654;3925.646691797723;3926.273639376696;5611.102223644198;5623.409541998113;5623.662580245198;5638.971805140989;5659.717014149276;3933.6853051755793;3939.330313846653;3941.5467221269346;3945.8951493581844;3980.900477488028;3923.1957448723515;4033.729375246788;4036.777977211223;4040;4040.7575545467366;4587.4036375271;4587.587117159472;4597.149527337453;4619.676622636451;4648;5476.835694929158;5498.670079795225;5502.339719233718;5514.862128446741;5522.171674248895;1350.4125705318218;1373.4300265389952;1379.951701690436;1382.8548002459797;1396.3297617143828;867.2628265973998;876.2639382918252;882.5146169606691;884.5886662701874;901.197933838884;4690.577847993697;4708.8116475341285;4710.387649605529;4726.929096063562;4790.976045119822;4989.725565093955;4999.600111968654;5014.7994080236385;5030.792609773701;5038.093143234253;4560.495036637902;4676.106176998321;4679.695819771704;4727.527247275245;4809.350737650442;2607.9478410431684;2614.6078088286527;2624.566946453852;2643.577027675601;2648.6424332715223;5040.722760248222;5057.747112644353;5072.605033615785;5087.329152195053;5110.61670374716;5056.721880296545;5420.756065977041;5749.712514374264;5756.481916627524;5780.797672081457;5857.765689372377;5872.911906321408;5873.3245676746865;5885.440883116097;5890.293164820249;5422.539084177889;5610.943890561042;5618.831435056954;5645.604807663424;5658.207850900795;5500.697461639648;5524.701695101568;5584.385717570983;5586.441355864544;5590.385057643737;5859.531237501075;5868.031774757117;5871.178035075179;5884.705764711662;5891.38140495259;3864.5748967612976;3940.428637847439;3953.822078006439;3965.940510892281;3966.8016599170505;5397.433269506802;5528.585356098389;5621.100623900156;5629.943700562942;5659.151127330933;5501.339839219319;5512.889742205213;5537.667739935617;5543.972280138573;5551.389347171888;5484.698341591251;5519.806806761744;5527.2538207341495;5532.336119665666;5533.952437598115;5204.137724251571;5440.156775699773;5444.346678398618;5448.793238738317;5456.236126942152;5526.944730552643;5531.280933478783;5541.536539662711;5552.833414997556;5565.972170139124;5116.232565115262;5348.331458567679;5413.7834486620095;5433.347998240237;5445.50990410865 15:53:40 INFO - PROCESS | 22710 | |5;yui.html;688.8587839492903;736.9189389167194;764.6100488750735;777.3703300326732;857.4897935728244;15210.087394756309;16031.759523607156;16477.340906363763;16499.670006599878;16958.152092395394;14663.780043299332;14719.190444525548;14894;15030.02304850184;15039.699206015874;640.8974564069749;784.0356361675157;792.4096548071694;794.5510786405691;794.570931696883;779.0262172284645;806.2300503019602;807.1444269074799;810.6068556749972;812.8374325134997;850.0521918061348;851.9914800852005;852.6163226548078;852.6972924611766;852.8336974290016;668.2482207516543;847.8770578266148;848.0925409811504;848.7071960173761;849.2526576612603;595.2143171014263;608.0362625238957;609.8505866062799;610.5573459242058;611.3611276216365;15774.526764197093;15827.129507877062;15835.12906790126;15844.841551584452;15858.207089645586;11915.94042029793;12112.636620901387;12433.440495177738;12517.624471265877;12824.422900969479;12525.874741252563;12623.053271004712;12844.935775321064;12971.481140754358;13186.07697461178;4159.542450330461;4208.978955105235;4262.701610887239;4336.306191009423;4339.262325404688;82242;84401.15598844056;85460.14539854646;85620;85879;10884.401357925231;10895.945520272347;11588.768224635629;11781.175317727677;12065.034797216202;21255.149794008375;21296.574068518545;21309.147634094774;21332.680009799864;21368.572628547652;8288.21261980111;8310.418270720991;8443.197896199852;8458.069612342637;8740.78148046304;4392.802323895432;4517.480489743656;4517.88705282364;4581.633469322446;4611.262198048296;3409.1817963688536;3518.20840310928;3523.894283171509;3538.133157376459;3552.87564935226;593.5904226083989;598.3806760003375;603.0712702438284;621.5027977617888;628.1174949196386;589.7464090441066;657.3459407889181;678.718331892269;697.4734075772759;728.6393235348536;9236.7690807729;9459.574319155654;9745.56144973478;9914.058164474363;9962;620.668457946235;645.3320812958565;672.0154972964631;697.6825544377297;702.4169938950658;4391.121775644884;4560.201964656172;4832.595075621531;4833.419989601271;4855.295982082649;122839.3858030722;124005;127473;127858;132495.3375233137;101176.49411753041;107638.46180769046;107880;111203.44398278119;113361;76566.23433765591;93987;94138;94652.52673736725;94658.52670736602;9320.533973301443;9347.672831450867;9435.764105897133;9445.811083778148;9573.090556397132;49554;49978.25032624441;50849.74575127249;54440;54520.45479545154;75249.62375188089;76997.61501192459;77202;80015;80284.59857700673;12831.743365132459;13403.32983350809;13767.586972390844;13829.585112446643;13834.861651383357;15546.766798497805;15696.372145114068;15892.920535397248;15909.840901590836;16048.518544443685;14154.858451415354;14637.560873173821;15012.249387530797;15081.321340539922;15450.84549154539;13924.16455012662;14017.5093871714;14163.504277350243;14690;15565.14391708467;13151.802722958972;13271.203727776365;13302.866971330162;13942.233177175352;15122.924385378003;11590.246633968765;11591.826122608336;11702.941485292518;11732.888913283285;11945.104117191071;10483.790324193626;10711.464426778473;10715.464226788785;11928.265795358117;12139.332336721565 15:53:40 INFO - PROCESS | 22710 | __end_tp_report 15:53:40 INFO - PROCESS | 22710 | __start_cc_report 15:53:40 INFO - PROCESS | 22710 | _x_x_mozilla_cycle_collect,999 15:53:40 INFO - PROCESS | 22710 | __end_cc_report 15:53:40 INFO - PROCESS | 22710 | __startTimestamp1470351220079__endTimestamp 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | ------- Summary: start ------- 15:53:40 INFO - PROCESS | 22710 | Number of tests: 6 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | [#0] dojo.html Cycles:165 Average:5371.54 Median:5568.11 stddev:610.62 (11.0%) stddev-sans-first:585.46 15:53:40 INFO - PROCESS | 22710 | Values: 3081.2 3094.9 3096.1 3116.0 3143.2 5305.8 5318.8 5367.9 5378.0 5418.6 5304.3 5373.4 5402.6 5444.0 5445.0 4812.0 4908.6 4912.9 4919.0 5075.1 4975.4 5004.2 5012.2 5027.7 5027.8 4780.0 4841.7 4948.7 4952.7 4957.0 4848.2 4861.8 4877.8 4940.9 5017.3 4878.0 4907.2 4913.8 4939.8 4988.3 5230.5 5276.0 5332.5 5378.1 5441.9 5712.9 5758.4 5808.4 5809.2 5815.3 5829.2 5843.8 5844.7 5847.9 5848.8 5266.2 5354.4 5357.8 5359.6 5436.2 5981.2 5985.0 5996.6 5996.9 5997.4 5713.2 5738.9 5752.7 5755.7 5760.5 5579.3 5695.2 5728.9 5745.8 5854.2 5747.3 5751.6 5753.2 5768.9 5802.5 5717.7 5766.3 5768.5 5774.0 5794.9 4328.6 4362.6 4385.6 4398.0 4448.1 3965.1 3977.5 4009.1 4010.5 4048.1 5488.8 5506.8 5513.9 5519.8 5559.1 5573.9 5747.0 5791.5 5812.6 5830.1 5506.9 5510.8 5519.6 5519.6 5568.1 5043.6 5043.6 5044.4 5046.6 5102.6 5731.8 5974.9 6033.1 6059.5 6069.0 5815.0 5838.0 5846.4 5848.2 5897.8 6060.7 6062.2 6075.9 6078.1 6079.7 5546.2 5547.5 5588.4 5688.2 5758.8 5686.7 5723.4 5734.7 5752.8 5774.4 5609.6 5613.5 5614.1 5616.7 5621.4 5372.3 5568.7 5570.7 5593.4 5595.0 5596.9 5599.0 5600.9 5639.8 5653.0 5685.6 5693.8 5725.9 5738.0 5749.6 5383.9 5390.1 5450.4 5529.0 5542.9 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | [#1] ext.html Cycles:180 Average:62594.97 Median:43630.17 stddev:122892.62 (281.7%) stddev-sans-first:123149.12 15:53:40 INFO - PROCESS | 22710 | Values: 566.2 600.0 603.3 613.8 617.9 32214.2 44285.6 44696.1 44987.0 45413.3 44677.8 45080.8 45099.0 45099.2 45115.3 8969.9 9125.3 9126.1 9128.2 9134.2 8942.6 9016.5 9026.9 9029.1 9036.7 9035.5 9087.9 9089.1 9090.9 9093.6 9024.9 9112.2 9118.2 9120.9 9122.0 8980.4 9031.9 9045.4 9053.6 9060.7 42567.6 42582.8 42888.4 42903.8 42904.0 3646.0 3658.9 3781.0 3886.6 4285.3 33429.2 33853.5 34069.7 34141.8 34954.7 4166.1 4294.6 4386.9 4425.5 4433.3 348639.0 349549.0 349845.0 349984.0 354859.0 60672.4 61189.4 61353.4 61400.4 61422.4 64581.4 64604.7 64718.0 64722.4 64730.4 17073.3 17233.5 17283.7 17284.8 17289.0 13357.7 13415.3 13424.1 13428.5 13430.9 16281.3 18235.5 18300.9 18354.2 18426.7 5755.3 5935.2 5997.4 6062.8 6074.7 699.8 1069.7 1072.5 1108.8 1119.5 32788.4 33967.5 33970.3 36672.4 37607.8 1064.6 1136.3 1145.9 1175.4 1196.8 17211.6 17672.6 17966.2 17982.0 18052.8 541393.0 547064.0 548800.0 549840.0 553464.0 59608.0 59841.7 59945.0 60107.4 60190.0 1238.4 1289.4 1291.7 1323.4 1348.4 30158.2 33262.2 34005.0 34151.0 37282.8 58315.0 58856.0 59002.0 59033.4 59071.1 468228.0 469766.0 471045.0 471407.0 471575.0 29024.7 29954.4 30161.5 30229.0 31860.5 47251.5 48807.5 49267.5 51178.5 53814.5 40709.4 43423.8 43850.6 44029.6 44780.6 42772.6 42899.0 43312.4 44302.8 44727.1 41875.2 42448.2 42680.1 42690.8 43836.6 35690.0 36237.0 37085.4 37775.4 39522.0 28949.4 29673.0 29718.9 29724.4 29801.0 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | [#2] jquery.html Cycles:180 Average:28976.02 Median:386.82 stddev:79130.38 (20456.8%) stddev-sans-first:79323.19 15:53:40 INFO - PROCESS | 22710 | Values: 359.6 374.8 376.4 384.4 389.3 14739.0 18771.3 18814.4 19189.9 20464.6 18686.6 20106.4 20202.9 20223.2 20226.8 5522.5 5812.5 5817.3 5819.3 5820.2 5542.3 5704.7 5776.7 5806.5 5808.7 5763.3 5768.7 5769.9 5769.9 5770.9 5599.5 5695.8 5720.5 5761.1 5765.9 5046.2 5110.6 5128.3 5137.0 5139.6 24292.5 24508.1 24695.1 24800.6 25007.6 2210.6 2220.7 2228.0 2949.8 3027.8 14511.8 14622.7 14994.6 15039.0 15324.2 1830.3 1870.3 1930.4 1948.8 1972.9 81498.6 84517.2 85321.6 85522.0 86633.0 10496.1 10576.4 10681.0 10951.2 10982.6 14628.1 14653.0 14653.1 14658.6 14659.6 7564.3 7687.8 7741.6 7943.4 8128.6 7057.8 7078.9 7094.6 7264.3 7310.3 4381.1 4392.1 4498.5 4564.2 4624.4 1920.4 1945.6 1963.4 1966.7 1982.0 839.4 923.0 980.3 993.8 1029.5 19594.9 20344.5 20345.6 20434.0 20439.6 909.4 959.0 961.3 969.4 990.8 10737.8 11279.3 11356.7 11390.1 11454.0 421694.0 441472.0 487836.0 516112.0 520149.0 84091.0 89572.1 93737.5 94542.5 96002.7 929.6 986.2 993.3 994.4 1005.9 17407.1 17682.6 17912.0 18061.5 18348.5 41847.8 43330.6 43537.3 44112.6 45095.1 55583.4 57405.1 59694.4 59798.1 60596.1 8511.9 8568.4 8573.7 8637.4 8695.6 12589.9 13402.7 13443.9 13612.6 13634.6 11494.8 11687.6 11817.5 11919.6 12079.5 11435.3 11660.8 12002.9 12023.4 12458.9 11667.5 11727.4 11763.9 12009.2 12301.2 7538.1 7632.2 7841.7 8127.3 9063.0 11730.0 11747.9 11810.5 11873.5 11920.3 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | [#3] mootools.html Cycles:180 Average:5783.90 Median:4868.81 stddev:3357.52 (69.0%) stddev-sans-first:3350.17 15:53:40 INFO - PROCESS | 22710 | Values: 1317.9 1452.2 1499.5 1608.5 1732.4 8321.6 8730.4 8753.6 9085.9 9097.2 8825.3 8993.2 9030.8 9041.7 9048.4 2347.6 2375.3 2375.4 2375.5 2377.2 2306.9 2330.2 2360.3 2365.7 2365.7 2290.0 2307.1 2316.5 2330.6 2335.8 2245.3 2272.5 2294.5 2294.5 2314.3 2277.7 2284.6 2285.6 2290.9 2291.8 8850.1 8910.5 9001.8 9002.3 9016.6 5087.2 5286.2 5292.4 5311.9 5316.1 3380.2 3393.6 3461.5 3462.1 3468.6 1073.6 1090.3 1091.3 1114.5 1132.8 12358.9 12375.4 12505.3 12515.3 12544.8 4336.8 4403.3 4501.8 4505.6 4594.1 9675.1 9689.5 9689.7 9699.9 9702.7 5214.9 5221.5 5224.4 5224.4 5230.8 4268.9 4779.0 4893.4 4902.3 4912.0 3689.9 3761.5 3775.8 3848.1 3859.0 1104.2 1128.2 1135.5 1138.8 1149.4 782.2 901.9 915.6 916.8 927.7 5486.7 5502.1 5577.2 5639.4 5664.3 968.6 979.2 980.8 1007.3 1007.6 3752.9 3867.0 3900.9 3931.6 3942.9 10813.5 11170.8 11187.9 11204.6 11212.0 10968.4 11003.9 11007.2 11079.9 11098.4 7949.8 8181.6 8303.4 8557.9 8688.3 5819.1 5835.9 5941.5 5994.1 6097.9 10465.7 10506.5 10508.0 10523.6 10620.2 10259.2 10431.4 10491.7 10508.3 10523.9 7107.0 7496.5 7531.7 7706.9 7722.8 8823.5 8910.6 8914.0 8914.5 8916.9 7598.4 7688.2 7822.8 7910.2 7946.6 7420.4 7476.9 7477.3 7562.3 7598.2 6633.1 6732.3 6734.5 6734.8 6742.4 4844.2 4948.9 4975.0 5067.5 5072.6 4776.1 4894.7 4917.4 4991.5 5028.9 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | [#4] prototype.html Cycles:180 Average:4524.23 Median:5065.18 stddev:1349.20 (26.6%) stddev-sans-first:1315.35 15:53:40 INFO - PROCESS | 22710 | Values: 308.1 309.0 317.4 320.4 321.5 5244.6 5271.7 5282.4 5286.6 5296.5 4934.7 5003.0 5132.9 5140.2 5219.6 4062.9 4068.5 4086.4 4105.8 4139.1 4054.3 4066.2 4092.5 4095.7 4098.8 3805.4 3894.9 4044.2 4055.2 4065.8 4040.1 4045.1 4054.4 4066.3 4069.4 3566.6 3577.9 3585.7 3586.2 3600.2 5009.3 5086.4 5108.0 5125.6 5146.8 4626.0 4630.0 4640.3 4652.6 4653.1 5419.3 5422.0 5422.5 5431.7 5438.2 3646.6 3825.4 3920.1 3925.6 3926.3 5611.1 5623.4 5623.7 5639.0 5659.7 3933.7 3939.3 3941.5 3945.9 3980.9 3923.2 4033.7 4036.8 4040.0 4040.8 4587.4 4587.6 4597.1 4619.7 4648.0 5476.8 5498.7 5502.3 5514.9 5522.2 1350.4 1373.4 1380.0 1382.9 1396.3 867.3 876.3 882.5 884.6 901.2 4690.6 4708.8 4710.4 4726.9 4791.0 4989.7 4999.6 5014.8 5030.8 5038.1 4560.5 4676.1 4679.7 4727.5 4809.4 2607.9 2614.6 2624.6 2643.6 2648.6 5040.7 5057.7 5072.6 5087.3 5110.6 5056.7 5420.8 5749.7 5756.5 5780.8 5857.8 5872.9 5873.3 5885.4 5890.3 5422.5 5610.9 5618.8 5645.6 5658.2 5500.7 5524.7 5584.4 5586.4 5590.4 5859.5 5868.0 5871.2 5884.7 5891.4 3864.6 3940.4 3953.8 3965.9 3966.8 5397.4 5528.6 5621.1 5629.9 5659.2 5501.3 5512.9 5537.7 5544.0 5551.4 5484.7 5519.8 5527.3 5532.3 5534.0 5204.1 5440.2 5444.3 5448.8 5456.2 5526.9 5531.3 5541.5 5552.8 5566.0 5116.2 5348.3 5413.8 5433.3 5445.5 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - PROCESS | 22710 | [#5] yui.html Cycles:180 Average:21995.43 Median:4391.96 stddev:32571.29 (741.6%) stddev-sans-first:32623.37 15:53:40 INFO - PROCESS | 22710 | Values: 688.9 736.9 764.6 777.4 857.5 15210.1 16031.8 16477.3 16499.7 16958.2 14663.8 14719.2 14894.0 15030.0 15039.7 640.9 784.0 792.4 794.6 794.6 779.0 806.2 807.1 810.6 812.8 850.1 852.0 852.6 852.7 852.8 668.2 847.9 848.1 848.7 849.3 595.2 608.0 609.9 610.6 611.4 15774.5 15827.1 15835.1 15844.8 15858.2 11915.9 12112.6 12433.4 12517.6 12824.4 12525.9 12623.1 12844.9 12971.5 13186.1 4159.5 4209.0 4262.7 4336.3 4339.3 82242.0 84401.2 85460.1 85620.0 85879.0 10884.4 10895.9 11588.8 11781.2 12065.0 21255.1 21296.6 21309.1 21332.7 21368.6 8288.2 8310.4 8443.2 8458.1 8740.8 4392.8 4517.5 4517.9 4581.6 4611.3 3409.2 3518.2 3523.9 3538.1 3552.9 593.6 598.4 603.1 621.5 628.1 589.7 657.3 678.7 697.5 728.6 9236.8 9459.6 9745.6 9914.1 9962.0 620.7 645.3 672.0 697.7 702.4 4391.1 4560.2 4832.6 4833.4 4855.3 122839.4 124005.0 127473.0 127858.0 132495.3 101176.5 107638.5 107880.0 111203.4 113361.0 76566.2 93987.0 94138.0 94652.5 94658.5 9320.5 9347.7 9435.8 9445.8 9573.1 49554.0 49978.3 50849.7 54440.0 54520.5 75249.6 76997.6 77202.0 80015.0 80284.6 12831.7 13403.3 13767.6 13829.6 13834.9 15546.8 15696.4 15892.9 15909.8 16048.5 14154.9 14637.6 15012.2 15081.3 15450.8 13924.2 14017.5 14163.5 14690.0 15565.1 13151.8 13271.2 13302.9 13942.2 15122.9 11590.2 11591.8 11702.9 11732.9 11945.1 10483.8 10711.5 10715.5 11928.3 12139.3 15:53:40 INFO - PROCESS | 22710 | -------- Summary: end -------- 15:53:40 INFO - PROCESS | 22710 | 15:53:40 INFO - TEST-INFO | 22710: exit 0 15:53:40 INFO - TEST-OK | dromaeo_css | took 1116017ms 15:53:40 INFO - TEST-START | kraken 15:53:40 INFO - operating with platform_type : linux_ 15:53:40 INFO - Initialising browser for kraken test... 15:53:40 INFO - TEST-INFO | started process 22913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2ZoBaF/profile http://localhost:48291/getInfo.html) 15:53:45 INFO - PROCESS | 22913 | __metrics Screen width/height:1600/1200 15:53:45 INFO - PROCESS | 22913 | colorDepth:24 15:53:45 INFO - PROCESS | 22913 | Browser inner width/height: 1024/697 15:53:45 INFO - PROCESS | 22913 | __metrics 15:53:46 INFO - PROCESS | 22913 | 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" 15:53:46 INFO - PROCESS | 22913 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:47 INFO - TEST-INFO | 22913: exit 0 15:53:47 INFO - Browser initialized. 15:53:47 INFO - Running cycle 1/1 for kraken test... 15:53:47 INFO - TEST-INFO | started process 22997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2ZoBaF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:59 INFO - PROCESS | 22997 | RSS: Main: 154902528 15:53:59 INFO - PROCESS | 22997 | 15:54:01 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48291/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:02 INFO - PROCESS | 22997 | RSS: Main: 211611648 15:54:02 INFO - PROCESS | 22997 | 15:54:05 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48291/tests/kraken/driver.html?testName=audio-dft) 15:54:05 INFO - PROCESS | 22997 | RSS: Main: 190849024 15:54:05 INFO - PROCESS | 22997 | 15:54:08 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48291/tests/kraken/driver.html?testName=audio-fft) 15:54:09 INFO - PROCESS | 22997 | RSS: Main: 266895360 15:54:09 INFO - PROCESS | 22997 | 15:54:11 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48291/tests/kraken/driver.html?testName=audio-oscillator) 15:54:12 INFO - PROCESS | 22997 | RSS: Main: 178528256 15:54:12 INFO - PROCESS | 22997 | 15:54:14 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:14 INFO - PROCESS | 22997 | RSS: Main: 183283712 15:54:14 INFO - PROCESS | 22997 | 15:54:17 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48291/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:18 INFO - PROCESS | 22997 | RSS: Main: 219697152 15:54:18 INFO - PROCESS | 22997 | 15:54:21 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48291/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:22 INFO - PROCESS | 22997 | RSS: Main: 218497024 15:54:22 INFO - PROCESS | 22997 | 15:54:25 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48291/tests/kraken/driver.html?testName=json-parse-financial) 15:54:25 INFO - PROCESS | 22997 | RSS: Main: 217788416 15:54:25 INFO - PROCESS | 22997 | 15:54:27 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:27 INFO - PROCESS | 22997 | RSS: Main: 182915072 15:54:27 INFO - PROCESS | 22997 | 15:54:29 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:30 INFO - PROCESS | 22997 | RSS: Main: 189394944 15:54:30 INFO - PROCESS | 22997 | 15:54:32 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:32 INFO - PROCESS | 22997 | RSS: Main: 193777664 15:54:32 INFO - PROCESS | 22997 | 15:54:35 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:36 INFO - PROCESS | 22997 | RSS: Main: 186494976 15:54:36 INFO - PROCESS | 22997 | 15:54:38 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:39 INFO - PROCESS | 22997 | RSS: Main: 191594496 15:54:39 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | Cycle 1(1): loaded http://localhost:48291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48291/tests/kraken/driver.html?testName=ai-astar) 15:54:41 INFO - PROCESS | 22997 | RSS: Main: 242372608 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | __start_tp_report 15:54:41 INFO - PROCESS | 22997 | _x_x_mozilla_page_load 15:54:41 INFO - PROCESS | 22997 | _x_x_mozilla_page_load_details 15:54:41 INFO - PROCESS | 22997 | |i|pagename|runs| 15:54:41 INFO - PROCESS | 22997 | |0;ai-astar;103;110;112;109;110;112;111;110;112;112 15:54:41 INFO - PROCESS | 22997 | |1;audio-beat-detection;146;116;118;168;123;123;139;118;161;118 15:54:41 INFO - PROCESS | 22997 | |2;audio-dft;161;160;159;160;160;160;162;164;163;161 15:54:41 INFO - PROCESS | 22997 | |3;audio-fft;75;74;77;117;77;76;75;75;102;75 15:54:41 INFO - PROCESS | 22997 | |4;audio-oscillator;84;85;121;85;84;84;111;84;84;128 15:54:41 INFO - PROCESS | 22997 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;118;116;116 15:54:41 INFO - PROCESS | 22997 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;147 15:54:41 INFO - PROCESS | 22997 | |7;imaging-desaturate;96;96;96;95;96;96;95;95;95;95 15:54:41 INFO - PROCESS | 22997 | |8;json-parse-financial;50;49;51;50;50;51;51;63;49;52 15:54:41 INFO - PROCESS | 22997 | |9;json-stringify-tinderbox;58;60;59;59;59;59;59;59;60;60 15:54:41 INFO - PROCESS | 22997 | |10;stanford-crypto-aes;77;79;83;85;82;75;75;74;75;80 15:54:41 INFO - PROCESS | 22997 | |11;stanford-crypto-ccm;120;130;121;120;130;130;124;120;138;129 15:54:41 INFO - PROCESS | 22997 | |12;stanford-crypto-pbkdf2;161;161;163;159;161;167;162;160;159;161 15:54:41 INFO - PROCESS | 22997 | |13;stanford-crypto-sha256-iterative;66;65;64;63;63;65;62;62;63;62 15:54:41 INFO - PROCESS | 22997 | __end_tp_report 15:54:41 INFO - PROCESS | 22997 | __start_cc_report 15:54:41 INFO - PROCESS | 22997 | _x_x_mozilla_cycle_collect,1617 15:54:41 INFO - PROCESS | 22997 | __end_cc_report 15:54:41 INFO - PROCESS | 22997 | __startTimestamp1470351281319__endTimestamp 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | ------- Summary: start ------- 15:54:41 INFO - PROCESS | 22997 | Number of tests: 14 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:2.73 (2.4%) stddev-sans-first:1.17 15:54:41 INFO - PROCESS | 22997 | Values: 103.0 110.0 112.0 109.0 110.0 112.0 111.0 110.0 112.0 112.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:131.00 stddev:19.37 (14.8%) stddev-sans-first:19.97 15:54:41 INFO - PROCESS | 22997 | Values: 146.0 116.0 118.0 168.0 123.0 123.0 139.0 118.0 161.0 118.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 15:54:41 INFO - PROCESS | 22997 | Values: 161.0 160.0 159.0 160.0 160.0 160.0 162.0 164.0 163.0 161.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:14.80 (19.7%) stddev-sans-first:15.46 15:54:41 INFO - PROCESS | 22997 | Values: 75.0 74.0 77.0 117.0 77.0 76.0 75.0 75.0 102.0 75.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:84.00 stddev:17.72 (21.1%) stddev-sans-first:18.34 15:54:41 INFO - PROCESS | 22997 | Values: 84.0 85.0 121.0 85.0 84.0 84.0 111.0 84.0 84.0 128.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:54:41 INFO - PROCESS | 22997 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 118.0 116.0 116.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 15:54:41 INFO - PROCESS | 22997 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:54:41 INFO - PROCESS | 22997 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.00 stddev:4.12 (8.1%) stddev-sans-first:4.32 15:54:41 INFO - PROCESS | 22997 | Values: 50.0 49.0 51.0 50.0 50.0 51.0 51.0 63.0 49.0 52.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 15:54:41 INFO - PROCESS | 22997 | Values: 58.0 60.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:79.50 stddev:3.89 (4.9%) stddev-sans-first:4.09 15:54:41 INFO - PROCESS | 22997 | Values: 77.0 79.0 83.0 85.0 82.0 75.0 75.0 74.0 75.0 80.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:129.50 stddev:6.12 (4.7%) stddev-sans-first:6.07 15:54:41 INFO - PROCESS | 22997 | Values: 120.0 130.0 121.0 120.0 130.0 130.0 124.0 120.0 138.0 129.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.00 stddev:2.32 (1.4%) stddev-sans-first:2.46 15:54:41 INFO - PROCESS | 22997 | Values: 161.0 161.0 163.0 159.0 161.0 167.0 162.0 160.0 159.0 161.0 15:54:41 INFO - PROCESS | 22997 | 15:54:41 INFO - PROCESS | 22997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.43 (2.3%) stddev-sans-first:1.20 15:54:41 INFO - PROCESS | 22997 | Values: 66.0 65.0 64.0 63.0 63.0 65.0 62.0 62.0 63.0 62.0 15:54:41 INFO - PROCESS | 22997 | -------- Summary: end -------- 15:54:41 INFO - PROCESS | 22997 | 15:54:42 INFO - TEST-INFO | 22997: exit 0 15:54:42 INFO - TEST-OK | kraken | took 61446ms 15:54:42 INFO - SUITE-END | took 1177s 15:54:42 INFO - Completed test suite (00:19:37) 15:54:42 INFO - javascript benchmark 15:54:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.2296925768574, 3094.9071527854157, 3096.071178646406, 3115.9844200778994, 3143.151349135733, 5305.7877684892555, 5318.813841515548, 5367.946320536794, 5378.0, 5418.5665146788215, 5304.310439642841, 5373.382061062969, 5402.648827826189, 5444.047291723952, 5445.019896418653, 4812.037592481509, 4908.631852611051, 4912.926306105393, 4919.040787046527, 5075.061113693979, 4975.378077740283, 5004.199328107504, 5012.248162775576, 5027.723475208881, 5027.798888044474, 4779.976100119512, 4841.685290456109, 4948.653594248404, 4952.727599981999, 4956.950430495685, 4848.22428411456, 4861.805527778884, 4877.804887804519, 4940.851774446773, 5017.34774479319, 4877.975610121962, 4907.190313598252, 4913.803447862081, 4939.8024079036795, 4988.251762235657, 5230.476952304777, 5276.0, 5332.520073193431, 5378.058839703036, 5441.863953401157, 5712.942870571283, 5758.395368486291, 5808.361080281208, 5809.215755872945, 5815.273090863642, 5829.154772557998, 5843.795467158671, 5844.678542680151, 5847.941520584783, 5848.766049358021, 5266.183741520071, 5354.4110147884485, 5357.812476563302, 5359.598030147677, 5436.157395603648, 5981.162637230791, 5984.970075149684, 5996.610220335664, 5996.910046349309, 5997.430244126801, 5713.171590119409, 5738.913916291259, 5752.6836024019085, 5755.65466072037, 5760.53915686744, 5579.2746942897165, 5695.202671625976, 5728.885422291614, 5745.798897038583, 5854.151148083589, 5747.281589801275, 5751.626144300607, 5753.165790960371, 5768.884622307614, 5802.535797136304, 5717.656940583578, 5766.308043034863, 5768.509676677446, 5773.971130144407, 5794.88410231793, 4328.567143285646, 4362.607365337135, 4385.627221686129, 4397.978010109929, 4448.110377924363, 3965.0682089708894, 3977.5226972762875, 4009.0578714002186, 4010.5387880393546, 4048.08917993455, 5488.807891723771, 5506.779728810883, 5513.9448605513435, 5519.751611177507, 5559.11054231321, 5573.944260557424, 5747.023006088975, 5791.507721843606, 5812.593118481665, 5830.125481177857, 5506.862328441821, 5510.779568817283, 5519.586031047607, 5519.586031047687, 5568.1091025435735, 5043.621728370387, 5043.646944713908, 5044.394672639307, 5046.62150338726, 5102.591792656579, 5731.799387021518, 5974.880502390015, 6033.095035744674, 6059.545534084873, 6069.0, 5815.0, 5837.970810145922, 5846.386129456346, 5848.152017957457, 5897.764089436375, 6060.666663333559, 6062.211912451353, 6075.939240607538, 6078.118672792332, 6079.665618391031, 5546.168074788814, 5547.500724934614, 5588.441155884379, 5688.203651488878, 5758.827235182951, 5686.744096515584, 5723.370429252862, 5734.684592347294, 5752.827415177551, 5774.364819869895, 5609.579281553982, 5613.522850557748, 5614.07367784311, 5616.747246373841, 5621.409751975983, 5372.328458942632, 5568.6658800472105, 5570.693611851225, 5593.356763972195, 5595.0, 5596.944030559643, 5599.0, 5600.85997850057, 5639.802606908738, 5653.038983372754, 5685.602007859576, 5693.800716974886, 5725.942740572707, 5738.0, 5749.626274292157, 5383.892322153457, 5390.110631745718, 5450.400455949922, 5529.032419326521, 5542.946840100368], "value": 5330.250760140033, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.1875209074977, 599.9580029397941, 603.2941458493565, 613.8434699151716, 617.9474744646704, 32214.194645133855, 44285.557144428545, 44696.10607787842, 44987.0, 45413.31880021798, 44677.77661111698, 45080.774596127056, 45099.0, 45099.16657084144, 45115.32327015098, 8969.865452018224, 9125.269978401746, 9126.133017363372, 9128.224100951395, 9134.223590994774, 8942.597583108743, 9016.54917254138, 9026.909730902673, 9029.142231487998, 9036.728898133033, 9035.457872527637, 9087.863682044775, 9089.136532029479, 9090.909090909105, 9093.590788414538, 9024.8646270306, 9112.179903808623, 9118.179363857285, 9120.908790912139, 9122.042185570486, 8980.371374003822, 9031.909680903173, 9045.412048216911, 9053.637854485813, 9060.682876099305, 42567.57432425667, 42582.78708606468, 42888.356674649905, 42903.78548107271, 42904.0, 3646.0, 3658.945115823238, 3781.0, 3886.5724770275247, 4285.335772955197, 33429.16427089342, 33853.49219761706, 34069.65930340714, 34141.82929085364, 34954.65045349565, 4166.145940082276, 4294.570542945712, 4386.868393948187, 4425.4894625265, 4433.290673492258, 348639.0, 349549.0, 349845.0, 349984.0, 354859.0, 60672.39327606756, 61189.38810611926, 61353.38646613566, 61400.38599614036, 61422.38577614256, 64581.35418645848, 64604.67697661576, 64718.0, 64722.35277647257, 64730.35269647243, 17073.31706731717, 17233.482995510156, 17283.74074388885, 17284.82715172832, 17289.0, 13357.666058348424, 13415.329233538285, 13424.127431716906, 13428.530001449903, 13430.93284533571, 16281.348746050262, 18235.45293641193, 18300.908495457705, 18354.174062167236, 18426.723599146022, 5755.280589926259, 5935.1987481690285, 5997.430244126801, 6062.787802426894, 6074.696265186723, 699.810737201684, 1069.668402795136, 1072.5012869015789, 1108.8170451875512, 1119.4906317625462, 32788.40962265285, 33967.4904876427, 33970.32059358799, 36672.44991325132, 37607.811960940024, 1064.5635289531256, 1136.2727854173336, 1145.9427028648533, 1175.3887978251262, 1196.8144937534696, 17211.56971075708, 17672.646547068987, 17966.191521381308, 17982.0, 18052.819471805113, 541393.0, 547064.0, 548800.0, 549840.0, 553464.0, 59608.0, 59841.70079149664, 59945.0, 60107.39892601018, 60190.0, 1238.3746208164819, 1289.4455384184891, 1291.7029083310704, 1323.4309247023873, 1348.393223049612, 30158.246043849078, 33262.16844578905, 34005.0, 34151.0, 37282.813585932985, 58315.0, 58856.0, 59002.0, 59033.40966590451, 59071.1139332919, 468228.0, 469766.0, 471045.0, 471407.0, 471575.0, 29024.7097529022, 29954.400911981204, 30161.547576786805, 30229.0, 31860.5220921691, 47251.52748472471, 48807.511924880295, 49267.50732492629, 51178.48821511737, 53814.46185538251, 40709.389359159046, 43423.782881086656, 43850.561494384645, 44029.55970440255, 44780.55219447764, 42772.572274276856, 42899.0, 43312.350314745934, 44302.77848610736, 44727.10545789131, 41875.162496750505, 42448.15103697847, 42680.14639707251, 42690.78654606707, 43836.561634383244, 35690.0, 36237.0, 37085.44371834479, 37775.43336849895, 39522.0, 28949.42101158007, 29673.0, 29718.851405742833, 29724.40551188921, 29801.0], "value": 20676.77634958253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.60443512136635, 374.76577139287934, 376.3658235872555, 384.3734712418757, 389.26040523006304, 14739.0, 18771.343002994898, 18814.435566932996, 19189.904050479727, 20464.590708185828, 18686.626267474643, 20106.396808095746, 20202.89898550509, 20223.191072357087, 20226.797732022675, 5522.502974732283, 5812.50593699534, 5817.301923769132, 5819.272590926134, 5820.214271073393, 5542.334919809608, 5704.743286552094, 5776.711164441782, 5806.477417032466, 5808.680522571257, 5763.279590051244, 5768.682722450264, 5769.855753606152, 5769.913451298234, 5770.913436298459, 5599.496045355897, 5695.800646977356, 5720.542356611461, 5761.078227483625, 5765.88468230633, 5046.243063540498, 5110.565601923841, 5128.333316668846, 5137.0496458154985, 5139.640225184238, 24292.514149717084, 24508.142215022388, 24695.135670251635, 24800.627990580157, 25007.62488562673, 2210.6462965925534, 2220.655798351258, 2228.0, 2949.8495586721197, 3027.7880548361622, 14511.782323265159, 14622.707545849129, 14994.62513437162, 15039.0, 15324.233788310652, 1830.2770405689812, 1870.2892900697784, 1930.4112245765036, 1948.7661480622273, 1972.8717633353785, 81498.59250703768, 84517.15482845154, 85321.57339213326, 85521.99999999937, 86633.0, 10496.107830834311, 10576.41829699374, 10681.03870651645, 10951.233413660968, 10982.560697572168, 14628.122312661275, 14653.0, 14653.12081275127, 14658.63353416173, 14659.633509162142, 7564.319211270902, 7687.769366919001, 7741.574213418204, 7943.44395892282, 8128.63421146038, 7057.823554411181, 7078.929210707827, 7094.574325540484, 7264.346208841124, 7310.268973102648, 4381.079973205662, 4392.099619578043, 4498.460184777848, 4564.1556312082375, 4624.398828152319, 1920.4238728381429, 1945.5816999345209, 1963.391348681913, 1966.6754985427244, 1981.9801801982085, 839.3998291221806, 923.0, 980.3235767320526, 993.7714325705128, 1029.464678367245, 19594.90202548978, 20344.49138771513, 20345.593088138154, 20434.0, 20439.591208175752, 909.3816204980677, 959.0122174160625, 961.3078583419926, 969.3892847506027, 990.8166989107038, 10737.83893241602, 11279.288823150213, 11356.659300221007, 11390.088792896548, 11454.0, 421694.0, 441472.0, 487836.0, 516112.0, 520149.0, 84091.0, 89572.0649061398, 93737.531312343, 94542.52728736312, 96002.7433615122, 929.6049179098856, 986.1913231150388, 993.3344659078434, 994.3741981859712, 1005.8826170910274, 17407.12964351752, 17682.5579360517, 17912.0, 18061.458156255332, 18348.541286467946, 41847.790761046, 43330.56669433265, 43537.346939795294, 44112.558874410846, 45095.098098038514, 55583.44416555944, 57405.13892291536, 59694.40305597062, 59798.10302845374, 60596.09105863504, 8511.914880851113, 8568.443051201652, 8573.657053717781, 8637.352198585257, 8695.60869760875, 12589.93705031469, 13402.664933376744, 13443.865561344652, 13612.591622251348, 13634.590962271148, 11494.827577586175, 11687.649370518899, 11817.468213930222, 11919.642410727693, 12079.51681932713, 11435.256708313933, 11660.766784664429, 12002.879971200176, 12023.398830058288, 12458.937705311415, 11667.474963626488, 11727.41362931833, 11763.941180294043, 12009.219400738924, 12301.200421972542, 7538.0954285483895, 7632.1986191451315, 7841.686332546634, 8127.268545830903, 9062.954685226532, 11730.002949749367, 11747.941260293986, 11810.468528916392, 11873.465694043962, 11920.284782912706], "value": 9274.444562635317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.8813906748403, 1452.2230606625453, 1499.5426394949543, 1608.5013645769811, 1732.4369579886531, 8321.62552685129, 8730.432521886072, 8753.606087726052, 9085.909140908589, 9097.181253687168, 8825.33809964252, 8993.190612844843, 9030.819383612325, 9041.683541076063, 9048.411853229536, 2347.6243800991847, 2375.2517956843626, 2375.3705268103968, 2375.5011447596025, 2377.239283429303, 2306.8961896714686, 2330.219376508863, 2360.303710405426, 2365.680633114525, 2365.6924599802087, 2290.0496294037953, 2307.100230909938, 2316.4672125411166, 2330.5571941331177, 2335.8364914455997, 2245.2815099168274, 2272.454610893382, 2294.4608017115966, 2294.542965217091, 2314.340412982309, 2277.7266727992746, 2284.6116160252795, 2285.645724912641, 2290.931272061841, 2291.7937385635373, 8850.114988501162, 8910.465372077697, 9001.819963600692, 9002.279817614575, 9016.59425325862, 5087.211482220262, 5286.233496143076, 5292.417834038252, 5311.920321195185, 5316.069687804657, 3380.20565167188, 3393.609734880471, 3461.4807778833124, 3462.1344663834043, 3468.5837699475974, 1073.6134991403167, 1090.2741020326418, 1091.3397394576325, 1114.4873358255213, 1132.8470656461354, 12358.876411235862, 12375.443105060294, 12505.312207828565, 12515.311657858905, 12544.81182782259, 4336.783160841946, 4403.2734598791485, 4501.774911254424, 4505.617022553054, 4594.0582180653555, 9675.129238368581, 9689.51552422376, 9689.70930872075, 9699.903000970042, 9702.660406885867, 5214.8957020860125, 5221.503957124143, 5224.399194092652, 5224.425313215544, 5230.764615592308, 4268.893277668021, 4778.976105119522, 4893.363862697897, 4902.338184345068, 4912.0, 3689.9077523062138, 3761.5486141663177, 3775.8300876460626, 3848.0764616491842, 3859.0352411897024, 1104.2049724198564, 1128.1651577832345, 1135.5060548661359, 1138.7608602193632, 1149.350616901448, 782.1865260129515, 901.8906744704051, 915.6207282216975, 916.7799728065349, 927.735595355334, 5486.670799752028, 5502.064649009678, 5577.163425486128, 5639.436056394327, 5664.291963504562, 968.6367612145445, 979.2264111352094, 980.8381617033252, 1007.2848277722752, 1007.6372505897871, 3752.887413377603, 3866.9613303867163, 3900.941485877714, 3931.6264954829244, 3942.8817135485983, 10813.513391897384, 11170.832437513443, 11187.944060279646, 11204.551817927355, 11212.0, 10968.396738179477, 11003.889961100447, 11007.229493935347, 11079.944600276947, 11098.44507774608, 7949.761507154794, 8181.631826567819, 8303.418760686694, 8557.871631925525, 8688.348373871859, 5819.1018342821135, 5835.94164058354, 5941.494972927349, 5994.130851026664, 6097.908531371944, 10465.68602941913, 10506.527206275889, 10508.0, 10523.631672891412, 10620.150387969099, 10259.17926565858, 10431.37411755297, 10491.68524944253, 10508.264421490423, 10523.894761052292, 7106.964465177848, 7496.475246732894, 7531.736389226351, 7706.884396734165, 7722.768316950501, 8823.514706691194, 8910.59902304385, 8914.0, 8914.465132092095, 8916.86624700643, 7598.430117741302, 7688.231176882267, 7822.804429889298, 7910.248526389983, 7946.562939038177, 7420.443466739908, 7476.925230747623, 7477.327040566158, 7562.319391254593, 7598.20218877032, 6633.1376920999965, 6732.259451460238, 6734.528582999143, 6734.764283250062, 6742.393184613212, 4844.249141383091, 4948.8762780930765, 4974.9502504975935, 5067.46791586878, 5072.644914855925, 4776.14029474684, 4894.681845680019, 4917.385326834145, 4991.5258050485145, 5028.874278143076], "value": 4591.428488109417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.0880593443406, 308.96755840636735, 317.41753881627204, 320.3608800443116, 321.53377602476417, 5244.632875698698, 5271.683698978054, 5282.392524859642, 5286.603504737141, 5296.496832800887, 4934.654574179809, 5003.0, 5132.894598767748, 5140.20326849338, 5219.634625576211, 4062.9436346549887, 4068.471098757172, 4086.3870419437176, 4105.774182419966, 4139.1100913303635, 4054.3107671695884, 4066.2311894325917, 4092.4857802613074, 4095.651869591088, 4098.8360465581345, 3805.4101614249835, 3894.8636797712084, 4044.231595996766, 4055.2092341993325, 4065.7560546367313, 4040.0909795295825, 4045.110075783323, 4054.432379466877, 4066.2680717470844, 4069.4302797608357, 3566.5898421681577, 3577.928441431183, 3585.731070169748, 3586.1751797086554, 3600.1539638185004, 5009.348784657971, 5086.353769812663, 5108.0, 5125.641205115643, 5146.768395422215, 4625.95374046262, 4630.0, 4640.303954406832, 4652.604528615072, 4653.092646933849, 5419.295491586108, 5422.0, 5422.457754224585, 5431.728413579305, 5438.238646589481, 3646.6353364663587, 3825.4261860721112, 3920.137569734654, 3925.646691797723, 3926.273639376696, 5611.102223644198, 5623.409541998113, 5623.662580245198, 5638.971805140989, 5659.717014149276, 3933.6853051755793, 3939.330313846653, 3941.5467221269346, 3945.8951493581844, 3980.900477488028, 3923.1957448723515, 4033.729375246788, 4036.777977211223, 4040.0, 4040.7575545467366, 4587.4036375271, 4587.587117159472, 4597.149527337453, 4619.676622636451, 4648.0, 5476.835694929158, 5498.670079795225, 5502.339719233718, 5514.862128446741, 5522.171674248895, 1350.4125705318218, 1373.4300265389952, 1379.951701690436, 1382.8548002459797, 1396.3297617143828, 867.2628265973998, 876.2639382918252, 882.5146169606691, 884.5886662701874, 901.197933838884, 4690.577847993697, 4708.8116475341285, 4710.387649605529, 4726.929096063562, 4790.976045119822, 4989.725565093955, 4999.600111968654, 5014.7994080236385, 5030.792609773701, 5038.093143234253, 4560.495036637902, 4676.106176998321, 4679.695819771704, 4727.527247275245, 4809.350737650442, 2607.9478410431684, 2614.6078088286527, 2624.566946453852, 2643.577027675601, 2648.6424332715223, 5040.722760248222, 5057.747112644353, 5072.605033615785, 5087.329152195053, 5110.61670374716, 5056.721880296545, 5420.756065977041, 5749.712514374264, 5756.481916627524, 5780.797672081457, 5857.765689372377, 5872.911906321408, 5873.3245676746865, 5885.440883116097, 5890.293164820249, 5422.539084177889, 5610.943890561042, 5618.831435056954, 5645.604807663424, 5658.207850900795, 5500.697461639648, 5524.701695101568, 5584.385717570983, 5586.441355864544, 5590.385057643737, 5859.531237501075, 5868.031774757117, 5871.178035075179, 5884.705764711662, 5891.38140495259, 3864.5748967612976, 3940.428637847439, 3953.822078006439, 3965.940510892281, 3966.8016599170505, 5397.433269506802, 5528.585356098389, 5621.100623900156, 5629.943700562942, 5659.151127330933, 5501.339839219319, 5512.889742205213, 5537.667739935617, 5543.972280138573, 5551.389347171888, 5484.698341591251, 5519.806806761744, 5527.2538207341495, 5532.336119665666, 5533.952437598115, 5204.137724251571, 5440.156775699773, 5444.346678398618, 5448.793238738317, 5456.236126942152, 5526.944730552643, 5531.280933478783, 5541.536539662711, 5552.833414997556, 5565.972170139124, 5116.232565115262, 5348.331458567679, 5413.7834486620095, 5433.347998240237, 5445.50990410865], "value": 4089.9413917724687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.8587839492903, 736.9189389167194, 764.6100488750735, 777.3703300326732, 857.4897935728244, 15210.087394756309, 16031.759523607156, 16477.340906363763, 16499.670006599878, 16958.152092395394, 14663.780043299332, 14719.190444525548, 14894.0, 15030.02304850184, 15039.699206015874, 640.8974564069749, 784.0356361675157, 792.4096548071694, 794.5510786405691, 794.570931696883, 779.0262172284645, 806.2300503019602, 807.1444269074799, 810.6068556749972, 812.8374325134997, 850.0521918061348, 851.9914800852005, 852.6163226548078, 852.6972924611766, 852.8336974290016, 668.2482207516543, 847.8770578266148, 848.0925409811504, 848.7071960173761, 849.2526576612603, 595.2143171014263, 608.0362625238957, 609.8505866062799, 610.5573459242058, 611.3611276216365, 15774.526764197093, 15827.129507877062, 15835.12906790126, 15844.841551584452, 15858.207089645586, 11915.94042029793, 12112.636620901387, 12433.440495177738, 12517.624471265877, 12824.422900969479, 12525.874741252563, 12623.053271004712, 12844.935775321064, 12971.481140754358, 13186.07697461178, 4159.542450330461, 4208.978955105235, 4262.701610887239, 4336.306191009423, 4339.262325404688, 82242.0, 84401.15598844056, 85460.14539854646, 85620.0, 85879.0, 10884.401357925231, 10895.945520272347, 11588.768224635629, 11781.175317727677, 12065.034797216202, 21255.149794008375, 21296.574068518545, 21309.147634094774, 21332.680009799864, 21368.572628547652, 8288.21261980111, 8310.418270720991, 8443.197896199852, 8458.069612342637, 8740.78148046304, 4392.802323895432, 4517.480489743656, 4517.88705282364, 4581.633469322446, 4611.262198048296, 3409.1817963688536, 3518.20840310928, 3523.894283171509, 3538.133157376459, 3552.87564935226, 593.5904226083989, 598.3806760003375, 603.0712702438284, 621.5027977617888, 628.1174949196386, 589.7464090441066, 657.3459407889181, 678.718331892269, 697.4734075772759, 728.6393235348536, 9236.7690807729, 9459.574319155654, 9745.56144973478, 9914.058164474363, 9962.0, 620.668457946235, 645.3320812958565, 672.0154972964631, 697.6825544377297, 702.4169938950658, 4391.121775644884, 4560.201964656172, 4832.595075621531, 4833.419989601271, 4855.295982082649, 122839.3858030722, 124005.0, 127473.0, 127858.0, 132495.3375233137, 101176.49411753041, 107638.46180769046, 107880.0, 111203.44398278119, 113361.0, 76566.23433765591, 93987.0, 94138.0, 94652.52673736725, 94658.52670736602, 9320.533973301443, 9347.672831450867, 9435.764105897133, 9445.811083778148, 9573.090556397132, 49554.0, 49978.25032624441, 50849.74575127249, 54440.0, 54520.45479545154, 75249.62375188089, 76997.61501192459, 77202.0, 80015.0, 80284.59857700673, 12831.743365132459, 13403.32983350809, 13767.586972390844, 13829.585112446643, 13834.861651383357, 15546.766798497805, 15696.372145114068, 15892.920535397248, 15909.840901590836, 16048.518544443685, 14154.858451415354, 14637.560873173821, 15012.249387530797, 15081.321340539922, 15450.84549154539, 13924.16455012662, 14017.5093871714, 14163.504277350243, 14690.0, 15565.14391708467, 13151.802722958972, 13271.203727776365, 13302.866971330162, 13942.233177175352, 15122.924385378003, 11590.246633968765, 11591.826122608336, 11702.941485292518, 11732.888913283285, 11945.104117191071, 10483.790324193626, 10711.464426778473, 10715.464226788785, 11928.265795358117, 12139.332336721565], "value": 7664.473792819546, "unit": "score"}], "name": "dromaeo_css", "value": 7265.836522266176, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 109.0, 110.0, 112.0, 111.0, 110.0, 112.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 118.0, 168.0, 123.0, 123.0, 139.0, 118.0, 161.0, 118.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 160.0, 160.0, 160.0, 162.0, 164.0, 163.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 117.0, 77.0, 76.0, 75.0, 75.0, 102.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 121.0, 85.0, 84.0, 84.0, 111.0, 84.0, 84.0, 128.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 51.0, 50.0, 50.0, 51.0, 51.0, 63.0, 49.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 83.0, 85.0, 82.0, 75.0, 75.0, 74.0, 75.0, 80.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 130.0, 121.0, 120.0, 130.0, 130.0, 124.0, 120.0, 138.0, 129.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 159.0, 161.0, 167.0, 162.0, 160.0, 159.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 63.0, 63.0, 65.0, 62.0, 62.0, 63.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1480.0000000000002, "alertThreshold": 2.0}]} 15:54:42 INFO - Return code: 0 15:54:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:42 INFO - # TBPL SUCCESS # 15:54:42 INFO - Running post-action listener: _resource_record_post_action 15:54:42 INFO - [mozharness: 2016-08-04 22:54:42.645185Z] Finished run-tests step (success) 15:54:42 INFO - Running post-run listener: _resource_record_post_run 15:54:42 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553295872; Read time: 12; Write time: 1194004 15:54:42 INFO - TinderboxPrint: CPU usage
13.1% 15:54:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:54:42 INFO - TinderboxPrint: I/O write bytes / time
553,295,872 / 1,194,004 15:54:42 INFO - TinderboxPrint: CPU idle
8,287.4 (86.9%) 15:54:42 INFO - TinderboxPrint: CPU user
1,195.7 (12.5%) 15:54:42 INFO - TinderboxPrint: Swap in / out
0 / 0 15:54:42 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 263884800; Read time: 0; Write time: 613308 15:54:42 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289312768; Read time: 0; Write time: 580652 15:54:43 INFO - Running post-run listener: _upload_blobber_files 15:54:43 INFO - Blob upload gear active. 15:54:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:43 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 15:54:43 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'] 15:54:43 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 15:54:43 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:48 INFO - (blobuploader) - INFO - Done attempting. 15:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:49 INFO - (blobuploader) - INFO - Done attempting. 15:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:49 INFO - (blobuploader) - INFO - Done attempting. 15:54:49 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:49 INFO - Return code: 0 15:54:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0dfe25ecc94ebba609011e2d1c60eee6d0b55c4ff94f83a1c5b6b6bf223d909e1125db0b8371d07f72dfb03a7b812811f182441a3e6e5d59724c51781977672", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b952c2f76ddfba05e8a4d25cc8f42dcfade96291ae7241f33acf8f16533193360780e0697ae3c6e254ce40ef34febad8c0d3587c061762e3c4bf958bb423794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01eb9a7d6e0a38d006feb026629d29234d50c68e669770f070f7469b5d79db96cb48796477037b140ee124234b39bcdaf14e56be8c10e92841a5fef2f942152f"} 15:54:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:49 INFO - Contents: 15:54:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0dfe25ecc94ebba609011e2d1c60eee6d0b55c4ff94f83a1c5b6b6bf223d909e1125db0b8371d07f72dfb03a7b812811f182441a3e6e5d59724c51781977672", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b952c2f76ddfba05e8a4d25cc8f42dcfade96291ae7241f33acf8f16533193360780e0697ae3c6e254ce40ef34febad8c0d3587c061762e3c4bf958bb423794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01eb9a7d6e0a38d006feb026629d29234d50c68e669770f070f7469b5d79db96cb48796477037b140ee124234b39bcdaf14e56be8c10e92841a5fef2f942152f"} 15:54:49 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:49 INFO - Copying logs to upload dir... 15:54:49 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.306340 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-04 15:54:49.775065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 15:54:49.779420) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705 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/b0dfe25ecc94ebba609011e2d1c60eee6d0b55c4ff94f83a1c5b6b6bf223d909e1125db0b8371d07f72dfb03a7b812811f182441a3e6e5d59724c51781977672", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b952c2f76ddfba05e8a4d25cc8f42dcfade96291ae7241f33acf8f16533193360780e0697ae3c6e254ce40ef34febad8c0d3587c061762e3c4bf958bb423794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01eb9a7d6e0a38d006feb026629d29234d50c68e669770f070f7469b5d79db96cb48796477037b140ee124234b39bcdaf14e56be8c10e92841a5fef2f942152f"} build_url:https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009980 build_url: 'https://queue.taskcluster.net/v1/task/b_qQouXAQVq4Bgf_7AXYkQ/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/b0dfe25ecc94ebba609011e2d1c60eee6d0b55c4ff94f83a1c5b6b6bf223d909e1125db0b8371d07f72dfb03a7b812811f182441a3e6e5d59724c51781977672", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b952c2f76ddfba05e8a4d25cc8f42dcfade96291ae7241f33acf8f16533193360780e0697ae3c6e254ce40ef34febad8c0d3587c061762e3c4bf958bb423794", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01eb9a7d6e0a38d006feb026629d29234d50c68e669770f070f7469b5d79db96cb48796477037b140ee124234b39bcdaf14e56be8c10e92841a5fef2f942152f"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 15:54:50.114702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:54:50.115088) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1470347573.985219-78089705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:54:50.194794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 15:54:50.198184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 15:54:50.198519) ========= ========= Total master_lag: 0.59 =========