builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1468376238.01 results: success (0) buildid: 20160712113033 builduid: 8cca8c68f3464c57a6d6ceda6bed02dc revision: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.014492) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.014847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.015112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.034653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.034913) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 19:17:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-12 19:17:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.146967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.147256) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021042 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.196753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.197055) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 --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 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 19:17:18,359 truncating revision to first 12 chars 2016-07-12 19:17:18,359 Setting DEBUG logging. 2016-07-12 19:17:18,359 attempt 1/10 2016-07-12 19:17:18,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55922a4a546c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 19:17:18,675 unpacking tar archive at: fx-team-55922a4a546c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677509 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.887401) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.887696) ========= script_repo_revision: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.888079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.888364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:17:18.898494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-12 19:17:18.898762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:17:19 INFO - MultiFileLogger online at 20160712 19:17:19 in /builds/slave/test 19:17:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:17:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:17:19 INFO - {'append_to_log': False, 19:17:19 INFO - 'base_work_dir': '/builds/slave/test', 19:17:19 INFO - 'blob_upload_branch': 'Fx-Team', 19:17:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:17:19 INFO - 'branch': 'Fx-Team', 19:17:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:19 INFO - 'config_files': ('talos/linux_config.py',), 19:17:19 INFO - 'default_actions': ('clobber', 19:17:19 INFO - 'read-buildbot-config', 19:17:19 INFO - 'download-and-extract', 19:17:19 INFO - 'populate-webroot', 19:17:19 INFO - 'create-virtualenv', 19:17:19 INFO - 'install', 19:17:19 INFO - 'run-tests'), 19:17:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:19 INFO - 'download_minidump_stackwalk': True, 19:17:19 INFO - 'download_symbols': 'ondemand', 19:17:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:19 INFO - 'installer_path': 'installer.exe', 19:17:19 INFO - 'log_level': 'info', 19:17:19 INFO - 'log_name': 'talos', 19:17:19 INFO - 'log_to_console': True, 19:17:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:17:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:17:19 INFO - 'opt_config_files': (), 19:17:19 INFO - 'pip_index': False, 19:17:19 INFO - 'sps_profile': False, 19:17:19 INFO - 'sps_profile_interval': 0, 19:17:19 INFO - 'suite': 'dromaeojs', 19:17:19 INFO - 'system_bits': '32', 19:17:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:19 INFO - 'title': 'talos-linux64-ix-026', 19:17:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:19 INFO - 'use_talos_json': True, 19:17:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:17:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:19 INFO - 'work_dir': 'build'} 19:17:19 INFO - ##### 19:17:19 INFO - ##### Running clobber step. 19:17:19 INFO - ##### 19:17:19 INFO - Running pre-action listener: _resource_record_pre_action 19:17:19 INFO - Running main action method: clobber 19:17:19 INFO - rmtree: /builds/slave/test/build 19:17:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:17:20 INFO - Running post-action listener: _resource_record_post_action 19:17:20 INFO - ##### 19:17:20 INFO - ##### Finished clobber step (success) 19:17:20 INFO - ##### 19:17:20 INFO - ##### 19:17:20 INFO - ##### Running read-buildbot-config step. 19:17:20 INFO - ##### 19:17:20 INFO - Running pre-action listener: _resource_record_pre_action 19:17:20 INFO - Running main action method: read_buildbot_config 19:17:20 INFO - Using buildbot properties: 19:17:20 INFO - { 19:17:20 INFO - "project": "", 19:17:20 INFO - "product": "firefox", 19:17:20 INFO - "script_repo_revision": "production", 19:17:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:17:20 INFO - "repository": "", 19:17:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:17:20 INFO - "buildid": "20160712113033", 19:17:20 INFO - "pgo_build": "True", 19:17:20 INFO - "basedir": "/builds/slave/test", 19:17:20 INFO - "buildnumber": 897, 19:17:20 INFO - "slavename": "talos-linux64-ix-026", 19:17:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:17:20 INFO - "platform": "ubuntu64_hw", 19:17:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:17:20 INFO - "branch": "fx-team", 19:17:20 INFO - "repo_path": "integration/fx-team", 19:17:20 INFO - "revision": "55922a4a546c9a6b5c6842aeb00b65c10b29bfc2", 19:17:20 INFO - "stage_platform": "linux64-pgo", 19:17:20 INFO - "builduid": "8cca8c68f3464c57a6d6ceda6bed02dc", 19:17:20 INFO - "slavebuilddir": "test" 19:17:20 INFO - } 19:17:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:17:20 INFO - Running post-action listener: _resource_record_post_action 19:17:20 INFO - ##### 19:17:20 INFO - ##### Finished read-buildbot-config step (success) 19:17:20 INFO - ##### 19:17:20 INFO - ##### 19:17:20 INFO - ##### Running download-and-extract step. 19:17:20 INFO - ##### 19:17:20 INFO - Running pre-action listener: _resource_record_pre_action 19:17:20 INFO - Running main action method: download_and_extract 19:17:20 INFO - mkdir: /builds/slave/test/build/tests 19:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:20 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:17:24 INFO - Downloaded 1361 bytes. 19:17:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:17:24 INFO - Using the following test package requirements: 19:17:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:17:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:17:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'jsshell-linux-x86_64.zip'], 19:17:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:17:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:17:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:17:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:17:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:17:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:24 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:17:29 INFO - Downloaded 24319804 bytes. 19:17:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:17:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:17:30 INFO - Return code: 0 19:17:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:30 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:17:34 INFO - Downloaded 24319804 bytes. 19:17:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:17:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:17:35 INFO - Return code: 0 19:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:35 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:17:36 INFO - Downloaded 14403317 bytes. 19:17:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:17:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:17:36 INFO - Return code: 0 19:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:36 INFO - https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:17:38 INFO - Downloaded 60493091 bytes. 19:17:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:38 INFO - mkdir: /builds/slave/test/properties 19:17:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:17:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:17:38 INFO - Contents: 19:17:38 INFO - build_url:https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:17:38 INFO - Running post-action listener: _resource_record_post_action 19:17:38 INFO - Running post-action listener: set_extra_try_arguments 19:17:38 INFO - ##### 19:17:38 INFO - ##### Finished download-and-extract step (success) 19:17:38 INFO - ##### 19:17:38 INFO - ##### 19:17:38 INFO - ##### Running populate-webroot step. 19:17:38 INFO - ##### 19:17:38 INFO - Running pre-action listener: _resource_record_pre_action 19:17:38 INFO - Running main action method: populate_webroot 19:17:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:38 INFO - '--tppagecycles', 19:17:38 INFO - '7'], 19:17:38 INFO - 'tests': ['tsvgm']}}, 19:17:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:17:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:17:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['damp', 'tps']}, 19:17:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'tests': ['damp', 'tps']}, 19:17:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['dromaeo_dom']}, 19:17:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['basic_compositor_video']}, 19:17:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:17:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['a11yr', 19:17:38 INFO - 'ts_paint', 19:17:38 INFO - 'tpaint', 19:17:38 INFO - 'sessionrestore', 19:17:38 INFO - 'sessionrestore_no_auto_restore', 19:17:38 INFO - 'tabpaint']}, 19:17:38 INFO - 'other-e10s': {'tests': ['a11yr', 19:17:38 INFO - 'ts_paint', 19:17:38 INFO - 'tpaint', 19:17:38 INFO - 'sessionrestore', 19:17:38 INFO - 'sessionrestore_no_auto_restore', 19:17:38 INFO - 'tabpaint']}, 19:17:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:17:38 INFO - 'ts_paint', 19:17:38 INFO - 'tpaint', 19:17:38 INFO - 'sessionrestore', 19:17:38 INFO - 'sessionrestore_no_auto_restore', 19:17:38 INFO - 'tabpaint']}, 19:17:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:17:38 INFO - 'ts_paint', 19:17:38 INFO - 'tpaint', 19:17:38 INFO - 'sessionrestore', 19:17:38 INFO - 'sessionrestore_no_auto_restore', 19:17:38 INFO - 'tabpaint']}, 19:17:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['a11yr', 19:17:38 INFO - 'ts_paint', 19:17:38 INFO - 'tpaint', 19:17:38 INFO - 'sessionrestore', 19:17:38 INFO - 'sessionrestore_no_auto_restore', 19:17:38 INFO - 'tabpaint']}, 19:17:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['a11yr', 19:17:38 INFO - 'ts_paint', 19:17:38 INFO - 'tpaint', 19:17:38 INFO - 'sessionrestore', 19:17:38 INFO - 'sessionrestore_no_auto_restore', 19:17:38 INFO - 'tabpaint']}, 19:17:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['tsvgx', 19:17:38 INFO - 'tsvgr_opacity', 19:17:38 INFO - 'tart', 19:17:38 INFO - 'tscrollx', 19:17:38 INFO - 'cart']}, 19:17:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:17:38 INFO - 'tsvgr_opacity', 19:17:38 INFO - 'tart', 19:17:38 INFO - 'tscrollx', 19:17:38 INFO - 'cart']}, 19:17:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'talos_options': ['--disable-e10s'], 19:17:38 INFO - 'tests': ['tp5o']}, 19:17:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'tests': ['tp5o']}, 19:17:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'talos_options': ['--disable-e10s', 19:17:38 INFO - '--xperf_path', 19:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:38 INFO - 'tests': ['tp5n']}, 19:17:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:38 INFO - 'talos_options': ['--xperf_path', 19:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:38 INFO - 'tests': ['tp5n']}}, 19:17:38 INFO - 'talos.zip': {'path': '', 19:17:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:38 INFO - Running post-action listener: _resource_record_post_action 19:17:38 INFO - ##### 19:17:38 INFO - ##### Finished populate-webroot step (success) 19:17:38 INFO - ##### 19:17:38 INFO - ##### 19:17:38 INFO - ##### Running create-virtualenv step. 19:17:38 INFO - ##### 19:17:38 INFO - Running pre-action listener: _resource_record_pre_action 19:17:38 INFO - Running main action method: create_virtualenv 19:17:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:17:38 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 19:17:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:17:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:39 INFO - Using real prefix '/usr' 19:17:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:17:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:41 INFO - Installing pip.................done. 19:17:41 INFO - Return code: 0 19:17:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 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 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:17:41 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 19:17:41 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 19:17:41 INFO - Using env: {'DISPLAY': ':0', 19:17:41 INFO - 'HOME': '/home/cltbld', 19:17:41 INFO - 'LANG': 'en_US.UTF-8', 19:17:41 INFO - 'LANGUAGE': 'en_US:en', 19:17:41 INFO - 'LOGNAME': 'cltbld', 19:17:41 INFO - 'MAIL': '/var/mail/cltbld', 19:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:41 INFO - 'MOZ_NO_REMOTE': '1', 19:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:41 INFO - 'NO_EM_RESTART': '1', 19:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:41 INFO - 'PWD': '/builds/slave/test', 19:17:41 INFO - 'SHELL': '/bin/bash', 19:17:41 INFO - 'SHLVL': '1', 19:17:41 INFO - 'TERM': 'linux', 19:17:41 INFO - 'TMOUT': '86400', 19:17:41 INFO - 'USER': 'cltbld', 19:17:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:41 INFO - '_': '/tools/buildbot/bin/python'} 19:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:41 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 19:17:41 INFO - Cleaning up... 19:17:41 INFO - Return code: 0 19:17:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:41 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 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:17:41 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 19:17:41 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 19:17:41 INFO - Using env: {'DISPLAY': ':0', 19:17:41 INFO - 'HOME': '/home/cltbld', 19:17:41 INFO - 'LANG': 'en_US.UTF-8', 19:17:41 INFO - 'LANGUAGE': 'en_US:en', 19:17:41 INFO - 'LOGNAME': 'cltbld', 19:17:41 INFO - 'MAIL': '/var/mail/cltbld', 19:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:41 INFO - 'MOZ_NO_REMOTE': '1', 19:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:41 INFO - 'NO_EM_RESTART': '1', 19:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:41 INFO - 'PWD': '/builds/slave/test', 19:17:41 INFO - 'SHELL': '/bin/bash', 19:17:41 INFO - 'SHLVL': '1', 19:17:41 INFO - 'TERM': 'linux', 19:17:41 INFO - 'TMOUT': '86400', 19:17:41 INFO - 'USER': 'cltbld', 19:17:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:41 INFO - '_': '/tools/buildbot/bin/python'} 19:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:42 INFO - Downloading/unpacking psutil>=3.1.1 19:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:44 INFO - Installing collected packages: psutil 19:17:44 INFO - Running setup.py install for psutil 19:17:44 INFO - building 'psutil._psutil_linux' extension 19:17:44 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 19:17:44 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 19:17:44 INFO - building 'psutil._psutil_posix' extension 19:17:44 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 19:17:44 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 19:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:44 INFO - Successfully installed psutil 19:17:44 INFO - Cleaning up... 19:17:44 INFO - Return code: 0 19:17:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:17:44 INFO - Using env: {'DISPLAY': ':0', 19:17:44 INFO - 'HOME': '/home/cltbld', 19:17:44 INFO - 'LANG': 'en_US.UTF-8', 19:17:44 INFO - 'LANGUAGE': 'en_US:en', 19:17:44 INFO - 'LOGNAME': 'cltbld', 19:17:44 INFO - 'MAIL': '/var/mail/cltbld', 19:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:44 INFO - 'MOZ_NO_REMOTE': '1', 19:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:44 INFO - 'NO_EM_RESTART': '1', 19:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:44 INFO - 'PWD': '/builds/slave/test', 19:17:44 INFO - 'SHELL': '/bin/bash', 19:17:44 INFO - 'SHLVL': '1', 19:17:44 INFO - 'TERM': 'linux', 19:17:44 INFO - 'TMOUT': '86400', 19:17:44 INFO - 'USER': 'cltbld', 19:17:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:44 INFO - '_': '/tools/buildbot/bin/python'} 19:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:17:46 INFO - Installing collected packages: mozsystemmonitor 19:17:46 INFO - Running setup.py install for mozsystemmonitor 19:17:46 INFO - Successfully installed mozsystemmonitor 19:17:46 INFO - Cleaning up... 19:17:46 INFO - Return code: 0 19:17:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:46 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 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:17:46 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 19:17:46 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 19:17:46 INFO - Using env: {'DISPLAY': ':0', 19:17:46 INFO - 'HOME': '/home/cltbld', 19:17:46 INFO - 'LANG': 'en_US.UTF-8', 19:17:46 INFO - 'LANGUAGE': 'en_US:en', 19:17:46 INFO - 'LOGNAME': 'cltbld', 19:17:46 INFO - 'MAIL': '/var/mail/cltbld', 19:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:46 INFO - 'MOZ_NO_REMOTE': '1', 19:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:46 INFO - 'NO_EM_RESTART': '1', 19:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:46 INFO - 'PWD': '/builds/slave/test', 19:17:46 INFO - 'SHELL': '/bin/bash', 19:17:46 INFO - 'SHLVL': '1', 19:17:46 INFO - 'TERM': 'linux', 19:17:46 INFO - 'TMOUT': '86400', 19:17:46 INFO - 'USER': 'cltbld', 19:17:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:46 INFO - '_': '/tools/buildbot/bin/python'} 19:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:47 INFO - Downloading/unpacking jsonschema==2.5.1 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:49 INFO - warning: no files found matching '*.txt' 19:17:49 INFO - no previously-included directories found matching 'build' 19:17:49 INFO - no previously-included directories found matching 'dist' 19:17:49 INFO - no previously-included directories found matching '.git*' 19:17:49 INFO - Installing collected packages: jsonschema, functools32 19:17:49 INFO - Running setup.py install for functools32 19:17:49 INFO - warning: no files found matching '*.txt' 19:17:49 INFO - no previously-included directories found matching 'build' 19:17:49 INFO - no previously-included directories found matching 'dist' 19:17:49 INFO - no previously-included directories found matching '.git*' 19:17:49 INFO - Successfully installed jsonschema functools32 19:17:49 INFO - Cleaning up... 19:17:49 INFO - Return code: 0 19:17:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:49 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 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:17:49 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 19:17:49 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 19:17:49 INFO - Using env: {'DISPLAY': ':0', 19:17:49 INFO - 'HOME': '/home/cltbld', 19:17:49 INFO - 'LANG': 'en_US.UTF-8', 19:17:49 INFO - 'LANGUAGE': 'en_US:en', 19:17:49 INFO - 'LOGNAME': 'cltbld', 19:17:49 INFO - 'MAIL': '/var/mail/cltbld', 19:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:49 INFO - 'MOZ_NO_REMOTE': '1', 19:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:49 INFO - 'NO_EM_RESTART': '1', 19:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:49 INFO - 'PWD': '/builds/slave/test', 19:17:49 INFO - 'SHELL': '/bin/bash', 19:17:49 INFO - 'SHLVL': '1', 19:17:49 INFO - 'TERM': 'linux', 19:17:49 INFO - 'TMOUT': '86400', 19:17:49 INFO - 'USER': 'cltbld', 19:17:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:49 INFO - '_': '/tools/buildbot/bin/python'} 19:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:49 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 19:17:49 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 19:17:49 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 19:17:49 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 19:17:49 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 19:17:49 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 19:17:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:17:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:17:51 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 19:17:51 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 19:17:51 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 19:17:51 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 19:17:51 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 19:17:51 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 19:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:17:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:17:52 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 19:17:52 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 19:17:52 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 19:17:52 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 19:17:52 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 19:17:52 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 19:17:52 INFO - Downloading docopt-0.6.1.tar.gz 19:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:17:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:17:52 INFO - Running setup.py install for blobuploader 19:17:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:17:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:17:52 INFO - Running setup.py install for requests 19:17:52 INFO - Running setup.py install for docopt 19:17:52 INFO - Successfully installed blobuploader requests docopt 19:17:52 INFO - Cleaning up... 19:17:52 INFO - Return code: 0 19:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 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 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:17:52 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 19:17:52 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 19:17:52 INFO - Using env: {'DISPLAY': ':0', 19:17:52 INFO - 'HOME': '/home/cltbld', 19:17:52 INFO - 'LANG': 'en_US.UTF-8', 19:17:52 INFO - 'LANGUAGE': 'en_US:en', 19:17:52 INFO - 'LOGNAME': 'cltbld', 19:17:52 INFO - 'MAIL': '/var/mail/cltbld', 19:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:52 INFO - 'MOZ_NO_REMOTE': '1', 19:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:52 INFO - 'NO_EM_RESTART': '1', 19:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:52 INFO - 'PWD': '/builds/slave/test', 19:17:52 INFO - 'SHELL': '/bin/bash', 19:17:52 INFO - 'SHLVL': '1', 19:17:52 INFO - 'TERM': 'linux', 19:17:52 INFO - 'TMOUT': '86400', 19:17:52 INFO - 'USER': 'cltbld', 19:17:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:52 INFO - '_': '/tools/buildbot/bin/python'} 19:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:53 INFO - Running setup.py (path:/tmp/pip-qt5Ivo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:53 INFO - Running setup.py (path:/tmp/pip-mvYcLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:53 INFO - Running setup.py (path:/tmp/pip-k2D0z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:53 INFO - Running setup.py (path:/tmp/pip-Zu_dda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:53 INFO - Running setup.py (path:/tmp/pip-VME3GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:53 INFO - Running setup.py (path:/tmp/pip-H2wTWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:53 INFO - Running setup.py (path:/tmp/pip-2oVS9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:53 INFO - Running setup.py (path:/tmp/pip-AFhkL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:53 INFO - Running setup.py (path:/tmp/pip-Lx0R9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:53 INFO - Running setup.py (path:/tmp/pip-L4MV5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:53 INFO - Running setup.py (path:/tmp/pip-yArea4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:53 INFO - Running setup.py (path:/tmp/pip-mvwJiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:54 INFO - Running setup.py (path:/tmp/pip-FF3Lhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:54 INFO - Running setup.py (path:/tmp/pip-s1DptZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:54 INFO - Running setup.py (path:/tmp/pip-pmoNEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:54 INFO - Running setup.py (path:/tmp/pip-ragmBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:54 INFO - Running setup.py (path:/tmp/pip-5LrMiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:17:54 INFO - Running setup.py install for manifestparser 19:17:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:17:54 INFO - Running setup.py install for mozcrash 19:17:54 INFO - Running setup.py install for mozdebug 19:17:54 INFO - Running setup.py install for mozdevice 19:17:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:17:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:17:54 INFO - Running setup.py install for mozfile 19:17:54 INFO - Running setup.py install for mozhttpd 19:17:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:17:54 INFO - Running setup.py install for mozinfo 19:17:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Running setup.py install for mozInstall 19:17:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Running setup.py install for mozleak 19:17:55 INFO - Running setup.py install for mozlog 19:17:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Running setup.py install for moznetwork 19:17:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Running setup.py install for mozprocess 19:17:55 INFO - Running setup.py install for mozprofile 19:17:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Running setup.py install for mozrunner 19:17:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:17:55 INFO - Running setup.py install for mozscreenshot 19:17:55 INFO - Running setup.py install for moztest 19:17:56 INFO - Running setup.py install for mozversion 19:17:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:17:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:17:56 INFO - Cleaning up... 19:17:56 INFO - Return code: 0 19:17:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:56 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 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:17:56 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 19:17:56 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 19:17:56 INFO - Using env: {'DISPLAY': ':0', 19:17:56 INFO - 'HOME': '/home/cltbld', 19:17:56 INFO - 'LANG': 'en_US.UTF-8', 19:17:56 INFO - 'LANGUAGE': 'en_US:en', 19:17:56 INFO - 'LOGNAME': 'cltbld', 19:17:56 INFO - 'MAIL': '/var/mail/cltbld', 19:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:56 INFO - 'MOZ_NO_REMOTE': '1', 19:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:56 INFO - 'NO_EM_RESTART': '1', 19:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:56 INFO - 'PWD': '/builds/slave/test', 19:17:56 INFO - 'SHELL': '/bin/bash', 19:17:56 INFO - 'SHLVL': '1', 19:17:56 INFO - 'TERM': 'linux', 19:17:56 INFO - 'TMOUT': '86400', 19:17:56 INFO - 'USER': 'cltbld', 19:17:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:56 INFO - '_': '/tools/buildbot/bin/python'} 19:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:56 INFO - Running setup.py (path:/tmp/pip-SJ6D2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:56 INFO - Running setup.py (path:/tmp/pip-Jrt9sX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:56 INFO - Running setup.py (path:/tmp/pip-gC4Na5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:56 INFO - Running setup.py (path:/tmp/pip-ifblfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:56 INFO - Running setup.py (path:/tmp/pip-dCLVrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:56 INFO - Running setup.py (path:/tmp/pip-VhRpXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:56 INFO - Running setup.py (path:/tmp/pip-NmdDCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:56 INFO - Running setup.py (path:/tmp/pip-Lh6pQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:56 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)) 19:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:56 INFO - Running setup.py (path:/tmp/pip-BRcxNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:57 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)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:57 INFO - Running setup.py (path:/tmp/pip-Sts9_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:57 INFO - Running setup.py (path:/tmp/pip-tlNwHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:57 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)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:57 INFO - Running setup.py (path:/tmp/pip-w6bZBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:57 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)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:57 INFO - Running setup.py (path:/tmp/pip-C0s_Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:57 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)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:57 INFO - Running setup.py (path:/tmp/pip-o2d163-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:57 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)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:57 INFO - Running setup.py (path:/tmp/pip-LM7QlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:57 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)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:57 INFO - Running setup.py (path:/tmp/pip-9D0wli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:57 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)) 19:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:57 INFO - Running setup.py (path:/tmp/pip-typct8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:57 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)) 19:17:57 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)) 19:17:57 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)) 19:17:57 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)) 19:17:57 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)) 19:17:57 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)) 19:17:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:17:57 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 19:17:57 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 19:17:57 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 19:17:57 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 19:17:57 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 19:17:57 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 19:17:59 INFO - Downloading blessings-1.6.tar.gz 19:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:17:59 INFO - Installing collected packages: blessings 19:17:59 INFO - Running setup.py install for blessings 19:17:59 INFO - Successfully installed blessings 19:17:59 INFO - Cleaning up... 19:17:59 INFO - Return code: 0 19:17:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:00 INFO - Reading from file tmpfile_stdout 19:18:00 INFO - Current package versions: 19:18:00 INFO - argparse == 1.2.1 19:18:00 INFO - blessings == 1.6 19:18:00 INFO - blobuploader == 1.2.4 19:18:00 INFO - docopt == 0.6.1 19:18:00 INFO - functools32 == 3.2.3-2 19:18:00 INFO - jsonschema == 2.5.1 19:18:00 INFO - manifestparser == 1.1 19:18:00 INFO - mozInstall == 1.12 19:18:00 INFO - mozcrash == 0.17 19:18:00 INFO - mozdebug == 0.1 19:18:00 INFO - mozdevice == 0.48 19:18:00 INFO - mozfile == 1.2 19:18:00 INFO - mozhttpd == 0.7 19:18:00 INFO - mozinfo == 0.9 19:18:00 INFO - mozleak == 0.1 19:18:00 INFO - mozlog == 3.2 19:18:00 INFO - moznetwork == 0.27 19:18:00 INFO - mozprocess == 0.23 19:18:00 INFO - mozprofile == 0.28 19:18:00 INFO - mozrunner == 6.12 19:18:00 INFO - mozscreenshot == 0.1 19:18:00 INFO - mozsystemmonitor == 0.3 19:18:00 INFO - moztest == 0.7 19:18:00 INFO - mozversion == 1.4 19:18:00 INFO - psutil == 3.1.1 19:18:00 INFO - requests == 1.2.3 19:18:00 INFO - wsgiref == 0.1.2 19:18:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:00 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 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:18:00 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 19:18:00 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 19:18:00 INFO - Using env: {'DISPLAY': ':0', 19:18:00 INFO - 'HOME': '/home/cltbld', 19:18:00 INFO - 'LANG': 'en_US.UTF-8', 19:18:00 INFO - 'LANGUAGE': 'en_US:en', 19:18:00 INFO - 'LOGNAME': 'cltbld', 19:18:00 INFO - 'MAIL': '/var/mail/cltbld', 19:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:00 INFO - 'MOZ_NO_REMOTE': '1', 19:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:00 INFO - 'NO_EM_RESTART': '1', 19:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:00 INFO - 'PWD': '/builds/slave/test', 19:18:00 INFO - 'SHELL': '/bin/bash', 19:18:00 INFO - 'SHLVL': '1', 19:18:00 INFO - 'TERM': 'linux', 19:18:00 INFO - 'TMOUT': '86400', 19:18:00 INFO - 'USER': 'cltbld', 19:18:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:00 INFO - '_': '/tools/buildbot/bin/python'} 19:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 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)) 19:18:00 INFO - Cleaning up... 19:18:00 INFO - Return code: 0 19:18:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a34030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', '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 19:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:18:00 INFO - Using env: {'DISPLAY': ':0', 19:18:00 INFO - 'HOME': '/home/cltbld', 19:18:00 INFO - 'LANG': 'en_US.UTF-8', 19:18:00 INFO - 'LANGUAGE': 'en_US:en', 19:18:00 INFO - 'LOGNAME': 'cltbld', 19:18:00 INFO - 'MAIL': '/var/mail/cltbld', 19:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:00 INFO - 'MOZ_NO_REMOTE': '1', 19:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:00 INFO - 'NO_EM_RESTART': '1', 19:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:00 INFO - 'PWD': '/builds/slave/test', 19:18:00 INFO - 'SHELL': '/bin/bash', 19:18:00 INFO - 'SHLVL': '1', 19:18:00 INFO - 'TERM': 'linux', 19:18:00 INFO - 'TMOUT': '86400', 19:18:00 INFO - 'USER': 'cltbld', 19:18:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:00 INFO - '_': '/tools/buildbot/bin/python'} 19:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:18:00 INFO - Cleaning up... 19:18:00 INFO - Return code: 0 19:18:00 INFO - Running post-action listener: _resource_record_post_action 19:18:00 INFO - Running post-action listener: _start_resource_monitoring 19:18:00 INFO - Starting resource monitoring. 19:18:00 INFO - ##### 19:18:00 INFO - ##### Finished create-virtualenv step (success) 19:18:00 INFO - ##### 19:18:00 INFO - ##### 19:18:00 INFO - ##### Running install step. 19:18:00 INFO - ##### 19:18:00 INFO - Running pre-action listener: _resource_record_pre_action 19:18:00 INFO - Running main action method: install 19:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:00 INFO - Reading from file tmpfile_stdout 19:18:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:00 INFO - Reading from file tmpfile_stdout 19:18:00 INFO - Output received: 19:18:00 INFO - Usage: mozinstall [options] installer 19:18:00 INFO - Options: 19:18:00 INFO - -h, --help show this help message and exit 19:18:00 INFO - -d DEST, --destination=DEST 19:18:00 INFO - Directory to install application into. [default: 19:18:00 INFO - "/builds/slave/test"] 19:18:00 INFO - --app=APP Application being installed. [default: firefox] 19:18:00 INFO - mkdir: /builds/slave/test/build/application 19:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:18:17 INFO - Reading from file tmpfile_stdout 19:18:17 INFO - Output received: 19:18:17 INFO - /builds/slave/test/build/application/firefox/firefox 19:18:17 INFO - Running post-action listener: _resource_record_post_action 19:18:17 INFO - ##### 19:18:17 INFO - ##### Finished install step (success) 19:18:17 INFO - ##### 19:18:17 INFO - ##### 19:18:17 INFO - ##### Running run-tests step. 19:18:17 INFO - ##### 19:18:17 INFO - Running pre-action listener: _resource_record_pre_action 19:18:17 INFO - Running main action method: run_tests 19:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:18:17 INFO - Python 2.7.3 19:18:17 INFO - Return code: 0 19:18:17 INFO - grabbing minidump binary from tooltool 19:18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:17 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 0x2cf33b0>, '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 0x2cf42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:18:17 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 19:18:17 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 19:18:17 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 19:18:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:18:18 INFO - Return code: 0 19:18:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:18:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:18:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:18:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:18:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:18:18 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/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:18:18 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/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:18:18 INFO - Using env: {'DISPLAY': ':0', 19:18:18 INFO - 'HOME': '/home/cltbld', 19:18:18 INFO - 'LANG': 'en_US.UTF-8', 19:18:18 INFO - 'LANGUAGE': 'en_US:en', 19:18:18 INFO - 'LOGNAME': 'cltbld', 19:18:18 INFO - 'MAIL': '/var/mail/cltbld', 19:18:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:18:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:18 INFO - 'MOZ_NO_REMOTE': '1', 19:18:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:18 INFO - 'NO_EM_RESTART': '1', 19:18:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:18 INFO - 'PWD': '/builds/slave/test', 19:18:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:18:18 INFO - 'SHELL': '/bin/bash', 19:18:18 INFO - 'SHLVL': '1', 19:18:18 INFO - 'TERM': 'linux', 19:18:18 INFO - 'TMOUT': '86400', 19:18:18 INFO - 'USER': 'cltbld', 19:18:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804', 19:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:18 INFO - '_': '/tools/buildbot/bin/python'} 19:18:18 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/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:18:18 INFO - mozversion application_buildid: 20160712113033 19:18:18 INFO - mozversion application_changeset: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 19:18:18 INFO - mozversion application_display_name: Nightly 19:18:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:18:18 INFO - mozversion application_name: Firefox 19:18:18 INFO - mozversion application_remotingname: firefox 19:18:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:18:18 INFO - mozversion application_vendor: Mozilla 19:18:18 INFO - mozversion application_version: 50.0a1 19:18:18 INFO - mozversion platform_buildid: 20160712113033 19:18:18 INFO - mozversion platform_changeset: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 19:18:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:18:18 INFO - mozversion platform_version: 50.0a1 19:18:18 INFO - using testdate: 1468376298 19:18:18 INFO - actual date: 1468376298 19:18:18 INFO - starting webserver on 'localhost:45859' 19:18:18 INFO - SUITE-START | Running 2 tests 19:18:18 INFO - TEST-START | dromaeo_css 19:18:18 INFO - operating with platform_type : linux_ 19:18:18 INFO - Initialising browser for dromaeo_css test... 19:18:18 INFO - TEST-INFO | started process 19749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdbFoXf/profile http://localhost:45859/getInfo.html) 19:18:22 INFO - PROCESS | 19749 | __metrics Screen width/height:1600/1200 19:18:22 INFO - PROCESS | 19749 | colorDepth:24 19:18:22 INFO - PROCESS | 19749 | Browser inner width/height: 1024/697 19:18:22 INFO - PROCESS | 19749 | __metrics 19:18:23 INFO - PROCESS | 19749 | 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" 19:18:23 INFO - PROCESS | 19749 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:18:23 INFO - PROCESS | 19749 | console.error: PushService: 19:18:23 INFO - PROCESS | 19749 | stateChangeProcessEnqueue: Error transitioning state 19:18:23 INFO - PROCESS | 19749 | UnknownError 19:18:23 INFO - TEST-INFO | 19749: exit 0 19:18:23 INFO - Browser initialized. 19:18:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:18:23 INFO - TEST-INFO | started process 19834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdbFoXf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:35 INFO - PROCESS | 19834 | RSS: Main: 157315072 19:18:35 INFO - PROCESS | 19834 | 19:19:27 INFO - PROCESS | 19834 | 1468376367246 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] 19:21:35 INFO - PROCESS | 19834 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45859/tests/dromaeo/cssquery-ext.html) 19:21:36 INFO - PROCESS | 19834 | RSS: Main: 260321280 19:21:36 INFO - PROCESS | 19834 | 19:24:38 INFO - PROCESS | 19834 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-ext.html (next: http://localhost:45859/tests/dromaeo/cssquery-jquery.html) 19:24:39 INFO - PROCESS | 19834 | RSS: Main: 237559808 19:24:39 INFO - PROCESS | 19834 | 19:27:41 INFO - PROCESS | 19834 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45859/tests/dromaeo/cssquery-mootools.html) 19:27:41 INFO - PROCESS | 19834 | RSS: Main: 227946496 19:27:41 INFO - PROCESS | 19834 | 19:30:43 INFO - PROCESS | 19834 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45859/tests/dromaeo/cssquery-prototype.html) 19:30:44 INFO - PROCESS | 19834 | RSS: Main: 234110976 19:30:44 INFO - PROCESS | 19834 | 19:33:47 INFO - PROCESS | 19834 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45859/tests/dromaeo/cssquery-yui.html) 19:33:47 INFO - PROCESS | 19834 | RSS: Main: 201007104 19:33:47 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | Cycle 1(1): loaded http://localhost:45859/tests/dromaeo/cssquery-yui.html (next: http://localhost:45859/tests/dromaeo/cssquery-dojo.html) 19:36:50 INFO - PROCESS | 19834 | RSS: Main: 281067520 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | __start_tp_report 19:36:50 INFO - PROCESS | 19834 | _x_x_mozilla_page_load 19:36:50 INFO - PROCESS | 19834 | _x_x_mozilla_page_load_details 19:36:50 INFO - PROCESS | 19834 | |i|pagename|runs| 19:36:50 INFO - PROCESS | 19834 | |0;dojo.html;3067.3405217878158;3089.135042188188;3107.300857307106;3111.0355789705177;3127.2338277122108;5382.2464854920345;5389.892202155959;5436.157395603678;5553.694546799924;5574;5364.5708343332535;5435.483629055233;5500.6424582402215;5522.641028333165;5534;4950.232713929347;5018.222175562793;5051.974740126313;5066.74666266687;5140.203268493389;5071.518205770446;5077.695338279696;5113.565346945496;5139.203423469368;5139.768710408022;4895.681780684262;4956.132676781567;4975.353204083446;4977.776000079969;5011.248312753098;4973.552380285755;4977.427595826454;5061.544460998528;5072.442031376546;5091.389033315989;4883.243097319921;5006.249062640597;5025.045241404122;5030.220315851049;5077.39071311445;5433.239346491494;5515;5528.75120619573;5579.609427340088;5626.549876009909;5913.526917846562;5919.378465261172;5932.436418540232;5943.970280148615;5947.791827286024;5741.88516229673;5811.27359080115;5885.61743486672;5949.821505354803;5991.3109992351;5590.496855283003;5596.468335508121;5597.552195824365;5601.663900165962;5608.2428872102155;6044.1469977857205;6091.573589848668;6101;6102.267727872595;6110.51115910735;5650.491455768918;5747.770089196469;5751.9424805751405;5787.189793428924;5891.057430811135;5983.700814959235;5987.9101813472835;6001.159837622737;6001.1898393717165;6002.159697642333;5892.234009578728;5919.348871624118;5921.3190483094995;5933.465988061095;5935.52515798735;5758.683272420057;5834.241548598655;5845.7369418376275;5855.707214639251;5944.108383742473;4457.353683715843;4496.955030449719;4500.257457519538;4500.684952053325;4506.549345065468;3952.9524675960893;3969.940450893239;3997.960020399759;4035.1929614077303;4061.9796901015307;5498.560115190775;5526.696031718294;5530.640508366943;5557.499825015768;5588.720563971785;5960.433758792908;5967.8209653710455;5969.104634304802;5970.820875373659;6003.099535069775;5429.457054294539;5467.1799230115;5562.16567514876;5574.470425309589;5579.637323573955;5017.071841709296;5086.821961231339;5089.312942752755;5104.821331253463;5146.433892271847;6091.177691011745;6094.695265236721;6096.512279017668;6103.511719062464;6107;5723.3418156912485;5872.794452194153;5907.4683278505145;5913.438223368945;5924.9703751480965;6168.814935551941;6181.907271390843;6182.165407669907;6195.504359651127;6199.318075011655;5873.3832947539895;5881.2942446906645;5882.382349853204;5886.705664716833;5932.822015339547;5739.167820665896;5794.101914203306;5844.912326315194;5989.580729348903;5992.370801065999;5775.537956963517;5809.477147056785;5817.185594016925;5825.854353641193;5852.4147585241135;5767.826965191051;5775.220345253505;5778.653280803165;5780.421957804186;5788.681622510802;5568.55451563882;5672.177534257427;5676.347220069745;5708.457696518824;5752.942470575241;5815;5815.244018277597;5824.21373114641;5875.177475153397;5875.676837773964;5602.2717046783655;5648.519875810438;5654.46282603152;5660.235868157746;5662.150677398423 19:36:50 INFO - PROCESS | 19834 | |1;ext.html;580.3297191743535;622.7042154976386;624.1012941364435;630.4704048599176;648.5298158834848;30871.228219294502;31309.843450782744;33823.323533529314;33860.66139338606;42546;40319.79840100795;44798.77600612;45065.549344506544;45075.54924450754;45083.77458112713;9025.458472491671;9181.724548263563;9184.173424391836;9185.632574697003;9191.586378612978;8951.552422378854;9022.368434209608;9030.187283144516;9037.819243615124;9038.728838134866;9090.909090909105;9153.63385464584;9170.679026234084;9173.816523669522;9177.724668259963;9043.140901614335;9058.909410905939;9081.182693557612;9088.727338179866;9095;8865.46807191564;8909;8933.285337173076;8936.285097192209;8949.686760963335;41982;42477;42517;42529.57470425287;42622.36066459006;3487;3558.395072837624;3682.39240525313;3732.5783103702756;4072.165206132736;33297.6670233297;33394;33660.83169584136;33671.663283367096;35260.47109293363;4461.553844615545;4467;4515.593596576324;4550.476695180064;4630.351750754863;374614;374762;375533;376209;378223;52596.474035259926;58349;59596;60348;60887.69556152191;64891;64987.35012649908;65203.673981629785;65225;65231.67384163049;16868.57828554296;17085.231164597622;17091.914540427217;17098.572535686708;17101.91449042747;12048.75902481963;12841.678958025937;13036.608901732963;13041.673958150932;13049.543265985645;19626.90186549058;19894.70157947632;19942.10260538279;20014.199432022557;20068.498287542636;7108.502404831612;7191.64041797908;7428.2571742825285;7433.888491672629;7438.6280685965485;940.8776859008285;975.6048800235916;1024.7438140464883;1113.7828123516;1160.6417900782508;33390.49914251288;33686.83156584201;34047.659523404946;34252.65747342545;34611.82694086513;1115.1134847796022;1123.1351859068473;1142.2004596782285;1180.474688763492;1197.7724232395817;17577.736333955;17812.9109354455;17903.552411189823;18011.639767204582;18069.457916262534;149777;150103;150146.24926875514;150239;150351;58855;60183;60216;60348.39651603428;60468.09297860535;1230.809224570193;1329.7739384304691;1367.2480135925202;1384.3908680180689;1401.7336706025822;32142.67857321397;33879.3224135511;34047;34460.655393446745;34691.65308346985;50120;50585;50679;50766.492335076175;50789.492105078476;429859;430659;431792;432375;432868;24905.252842414757;27003.1899043029;28295.2926176839;28393.716062839107;29690.406191876475;43798.56201437945;48811.511884880696;49021.75489122532;49153.26270106023;50389;40911.59088409078;42039.1592168161;42423.787881060394;43084.78457607692;43739.56260437482;41505.1698966025;41667.37498937579;42043.36934945917;43087.784561076995;43124.13751725011;41944.580554194064;42708.78645606877;43123;43260.783696081315;43274.13451730885;35254.29491410106;36870.865976392306;37056;37588.248235034596;38325.23349532938;29056.709432906246;29099;29179.7082029177;29355;29452.116436506938 19:36:50 INFO - PROCESS | 19834 | |2;jquery.html;389.47615457210077;389.6960370910687;399.28527934996356;399.7681344820004;413.48108124303997;18681.159347829347;19209.807901920994;19329.71005434918;19567.315143969965;20993.265235716754;19086;19907.104180311886;19916;19934.102965366557;20602.278920237793;5179.533841954223;5241.895162096746;5321.308229930123;5324.094903866333;5327.653702509344;5232.7383630818495;5252.080885844962;5257.36911570612;5258.579313654917;5276;5106.64253502255;5284.048871203182;5294.179402192666;5300.787968481275;5307.177387504943;5234.659747116425;5258.526732594085;5275.947240527584;5307.2569840222395;5308.071087559681;5054.393472783289;5181.844544663666;5359.1425371940695;5367.409584945653;5419.105847535152;14024.579262622137;14098.647533811736;14127.223002734845;23607.29178124659;24788.132415365555;2543.771060604536;2609.9869500652376;2647.113217072283;2754.352727109128;3002.0993701889565;10315.226358023177;10552.894471055268;10790.67627971162;11310.886891131066;13050.086493945428;1996.4809149621058;2020.1212472574477;2031.4819720971207;2040;2063.432556047084;85662.57168714178;86332;87450.93921712709;87613.56193219057;91849.54075229581;11135;11317.717057073474;11446.198766086294;11534.307941523535;12376;15688;15848.366065357488;15850.128242946517;15875.682486350208;15880.047197168207;8377.078521362646;8379.62291696875;8408.369372297102;8482.406231563855;8601.870971935426;8167.714130005421;8211.137830527709;8251.669933202726;8326.250637442537;8401.915980840113;4837.830675926326;4846.854594362175;4857.95142048575;4900.313956046157;4932.580730637936;2006.7491563554556;2038.9490262743254;2045.263705066175;2047.7133201351824;2053.404512691303;1021.9948900255451;1040.8126537223372;1043.5512729526224;1066.5200659703164;1094.9178811589004;19851.702224466644;19978.30075947335;20750.584988300452;21057.157713691282;21512.569748605252;969.4183489906;1001.4441984698562;1015.4161357219629;1031.4533297352416;1035.30634474902;10812.135029197645;11478.770424591461;11487.42562871853;11488.88511114895;11603.129765267639;510745;528512;534323;536161;547513;82174;88812;100494;101763;103140;1003.0721582536125;1011.4740335025892;1044.0081922173813;1052.952617132231;1069.5882085397022;18814.717779233597;18827.90586047061;18844.623107538046;18914.621707566046;19041.42875713731;41664.583354167284;43773.78113109541;44321.55678443174;44416.333754994346;45059;61419;62654.68672656608;62815.371846280956;64015.35984640094;64388;7827.295543401121;8437.156284371758;8649.91350086491;8703.695370661997;8773.29813614922;9884.802303954024;13776;14394.784078238625;14655.974081814597;14729.410823566937;10003.34978226413;12181.634550963485;12204.938975305067;12326.938365308117;12389.256644601353;10827.24209305341;10840.457977100956;11526.135539834713;11877.82183267269;12115.81826272589;12601.991840652543;12696.936515317364;12770.61688149357;12809.679758005752;12942.935285323512;8149.348052155695;8163.306118979715;8387.454815436977;8432.578371081545;8496.617652205789;8456.365772566958;8795.604197811243;8821.514816685143;8981.550922453982;9572.617095316109 19:36:50 INFO - PROCESS | 19834 | |3;mootools.html;1497.1092200140915;1498.8276348219954;1667.374734474572;1794.1567463292256;1798.1189217283536;8718.564071796409;9241.722748317561;9314.953425232872;9321.114494123065;9333.766655833599;7881.566513841736;8419.536925469112;8649.437786543871;8671.393002489829;9050.1854833065;2356.9764302357016;2387.5821731197057;2389.3787615219994;2390.0439824070336;2391.5336509380677;2020.464576887126;2347.7417484076736;2364.959417856138;2366.4320563064825;2370.0756704885107;2192.7368715754133;2245.113180293783;2256.571251462225;2284.3375421127853;2289.290320000805;2262.3891549281766;2290.6220473621834;2303.262955854119;2307.5500277445904;2308.4805918668335;2244.068711484732;2277.7152855893014;2281.7376001759676;2284.1091974130104;2293.483966107629;9113.817723645556;9213.585388657526;9215.308851836073;9218.539073046388;9225.492597907112;5236.083685355047;5280.2079688046715;5287.154055351164;5311.229871668586;5427.83716488506;3358.395488812013;3461.463473161664;3508.3158784037123;3537.6816086552076;3543.7519373643854;1175.1186610042469;1179.262960649594;1195.6413076077142;1197.1978774221293;1218.8598311194237;12838.101332906606;12848.293343866084;12867;12873.420696068606;12916.547920822726;4537.568930951555;4627.074585082997;4772.832950846704;4781.521847815191;4825.9758701206265;10686.091682206945;10702.73243168927;10777.08394786452;10787.730306742395;10793.460326983777;5413.296271484761;5416.0521908666615;5419.3225846769155;5420.701861397582;5431.864203394946;4945.579625731782;4981.178105612606;4992.500749924979;5010.098182327143;5052.797888084509;4122.546519882811;4156.854510092132;4202.831886724497;4204.789760511962;4244.087521182961;1170.666360087388;1270.371166272701;1280.5715309148025;1292.5799115287568;1300.6423233610833;824.1593574553922;889.226373055446;934.7055677461578;943.2359788571142;968.7527802216264;5695.515881150066;6030.728617212236;6072.392760723892;6199;6334.5565810393755;928.8049509603059;929.7773427942369;955.6607404371348;962.5812771444444;1039.8232300508932;3964.781936993493;4071;4115.259253334429;4158.189153115113;4184.309588917795;10870.836937445945;11199.60801371948;11444.54221831134;11572.363520006313;11578.71053223676;10687.732806679895;11050;11098.389588572545;11538.365389903636;11547.769044619228;8446.788830279169;8523.872141917876;8538.188872057144;8563.357748168788;8568.828623427496;6052.152698622284;6236.158118654105;6267.529935254783;6301.6534090625455;6302.212223472066;10647.041766240765;10679.8932010682;10693.625723099654;10787.67636970892;10841.837372439577;10473.21450891171;10682.679519614425;11011.174161938046;11043.558257669603;11148.554057837595;8020.558869262247;8065.9596702016115;8094.392920530866;8101.594920253846;8129.878051829109;8577.914220857712;8623.137686231326;8675.566221688765;8683.044865064712;8726.040135585208;7534.6609402578115;7538.413170515071;7543.7736867894055;7624.27569380908;7634.083909930844;7868.173841746534;7905.881411778943;7989.8402031960195;8012.479188852939;8045.678172873019;7123.145222573325;7181.497295189287;7182.138143422822;7184.533005354635;7186.748463803742;4996.475370086234;5028.069807085701;5063.974680126576;5138.614603904647;5184.662996905189;5002.499750024968;5013.348264725562;5030.4466508684745;5294.655847369909;5423.484768946943 19:36:50 INFO - PROCESS | 19834 | |4;prototype.html;315.33936403235214;319.3692457396641;323.65854024004665;333.4098645397645;337.0797722218344;5274.762635681394;5358.383785864627;5369.791796845708;5379.704116273609;5383.67697938124;5052.696838189711;5187;5198.324217851674;5206.973965130179;5344.331958505187;4059.167870586523;4116.506019277691;4198.958010419902;4207.8007767786185;4217.578242175773;4131.380292956051;4157.771322577257;4175.185838761443;4188.6649068074485;4196.265653510639;4071.2875246831836;4124.546299907008;4134.586541345856;4136.084060737173;4177.7284476509085;4082.3060079786505;4085.529209484583;4095.5494895561465;4125.958740412588;4137.40007698885;3656.9943265601905;3658;3661;3679.4664773607947;3699.500567423417;5040.42035165957;5160.56135228506;5181.792728290864;5199.766010529497;5214.504622060898;4740.95259047412;4765.928511072337;4775.689580177312;4783;4788.736619485927;5472.1244600864065;5487.478689524529;5503.7798488060425;5520.7854272060085;5545.223668686387;3976.403539469074;4072.9796351018354;4078.5513593504693;4089.8364065437345;4091.345384738457;5604.999999999959;5641.576881733887;5660.773569057233;5669.177969194444;5728.369879313273;4167.1457351242925;4187;4193.433886425354;4206.432131662247;4212.262854000538;4089.734167279117;4235.152969406069;4236.724612900213;4252.936205956913;4257.914841703148;4725.69282996611;4739.218029025173;4752.881177970578;4757.95242047582;4788.712677239377;5535.391106978229;5598.692071936001;5607.467290607386;5612.97193514038;5619.00525313516;1321.447299423193;1382.5990462765888;1432.9355179016968;1446.5534465534465;1451.903812621464;996.2279233594022;1004.2869562610482;1008.7642637768674;1015.6491865818443;1019.56158851693;5220.389805097451;5283.947160528345;5306.7611957462;5324.866878327995;5336.91994620081;5590.580706446952;5591.217229587861;5592.692401917852;5623.662580245198;5634.690092044977;5161.716105614228;5335.1730481775385;5399.298091248191;5411.431799660979;5422.078246698071;2940.8823647053878;2990.2524368907775;2997.925051873721;3000.1899487138785;3004.9248768780953;5683.886322273532;5853.590248682636;5856.652969816966;5859.94140058594;5863.355030946593;5767.509761670305;5786.987277226469;5791.160281759121;5809.390014048548;5815.73829177688;5836.153757705109;5837.737301821513;5846.2692163480415;5863.765449382062;5888.263967004124;5440.0959664117245;5586.217929489956;5651.237082993744;5657.840142770639;5660.320761508646;5557.555395568425;5559.305086864142;5574.293095091719;5584.832455026356;5599.612234598009;5578.832635020955;5798.782255726344;5825.970870145622;5830.76676932918;5904;4014.578469260802;4116.485439320085;4153.356229784388;4162.250794856955;4170.937435938524;5612.85967850807;5711.485966263056;5734;5734.7132643368495;5830.358660547252;5484.464349982011;5536.889262214814;5571.387147413862;5572.442755724395;5581.6930068846605;5270.683758974474;5506.174073888948;5517.172424136412;5542.528885044816;5568.1091025435735;5517.724113794214;5540.75066622011;5562.165675148598;5564;5567.220589117608;5597.860053498695;5609.270794796814;5616.1856530803625;5620.831375058755;5645.943540564542;5177.4822517747925;5475.863103422446;5496.862578435571;5499.670019798825;5508.614396992172 19:36:50 INFO - PROCESS | 19834 | |5;yui.html;694.5207806613433;711.690414669619;767.3784234769837;768.1962771263107;864.0927026622045;14181.078229915061;15005.099694018367;15107.169105699182;15142.470013549528;15159.317830697604;15036.624084397896;15237.619059523517;15278.465253716095;15292.923535382335;15293.464728734496;645.5835985789163;796.7569891183186;816.3754727633366;820.409305300183;834.4117397234935;818.5007145641155;822.7202751064636;823.7816978500703;825.6449726617582;826.4958375391006;690.3441730356157;863.641588740675;865.03548543374;865.8441480533502;866.7399780065987;706.2760670312945;707.1584814071265;819.1439945257191;840.3949156607295;842.4860834890711;629.7984644913629;630.0171732097942;630.6090224061112;630.9936900631027;631.1290419221491;14841.925790371088;14936.70126597462;14971.251437428085;14980.1011939284;14996.175210363426;14026.509072182527;14296.857031429761;14314.355853986492;14429.71140577193;14642.707145857023;12445.564405245774;12459.314737689423;12510.437030333565;12593.93703031479;12646.620601381974;4388.824447022147;4407.801648925806;4418.5581441855875;4459.910801783946;4537.31940208968;78565;78748.60625696892;79005;79438.20561794423;79639.60180199062;10950.507227174796;10967.50646220922;10970.177236707279;11098.61154859576;11317.83023254652;21735.347939561838;21753.12987480515;21756.12975480963;21769.673454898188;21788.673169902464;8710.520921349387;8744.737657870273;8976.775580610407;9011.504367259864;9032.45805251687;4779.545943135397;4886.340344053508;4907.607391408679;5025.095482813055;5178.093833579109;3392.3384939936477;3477.7043951264427;3488;3490.5985811631986;3492.7904325740537;533.3812777178455;613.5858295650418;625.2902955145942;636.9426751592379;651.7718798420515;716.183550752143;722.2705067881477;725;735.3051366458645;746.220199891115;9640.75898102539;10265.486725663686;10336.5348559315;10694.983976522219;10941;595.3808039638814;683.3439897698166;711.416638356553;721.6788529104498;726.0307489501469;4734.147853386355;5069.569086627678;5239.161734122522;5279.52484276417;5354.437784032621;113371;123773;129269.35365323113;130438;132808;98859.50570247247;100349;101041.87497500348;102455.48772256241;103966.4801676002;72760.2723972764;72769;75189.62405188048;87835;89879.55060224657;10098.343607665773;10164.539289988152;10168.034036766496;10168.898311016796;10482.423466709404;53031.63620365426;53038;53113.7344313276;53119;54464.45535544594;73951;79775;80909;81223.59388203258;81386.59306703428;13149.671258218621;13494.32528373597;13510.594682159552;13597.932010339884;13614.727705446034;14311;14631.780523292373;14635.268236587915;15170.696586068438;15410.537683869501;14061;14160.150390976574;14397.64005899861;14492.927535362256;14744.705105898036;14509.201993890438;14640.487582934973;14684.192369419785;14732.189729564976;15021.549353519413;14368.209748463934;14575.927120364755;14972.625684357978;15085.773713394527;15099;11417.885821141683;11440;11724.355160465915;11891.227070240408;11942.522299108286;11496;11568.768624627292;11902.166848320534;12039.33783641873;12179.512819487121 19:36:50 INFO - PROCESS | 19834 | __end_tp_report 19:36:50 INFO - PROCESS | 19834 | __start_cc_report 19:36:50 INFO - PROCESS | 19834 | _x_x_mozilla_cycle_collect,902 19:36:50 INFO - PROCESS | 19834 | __end_cc_report 19:36:50 INFO - PROCESS | 19834 | __startTimestamp1468377410581__endTimestamp 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | ------- Summary: start ------- 19:36:50 INFO - PROCESS | 19834 | Number of tests: 6 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | [#0] dojo.html Cycles:165 Average:5486.43 Median:5672.18 stddev:641.39 (11.3%) stddev-sans-first:614.64 19:36:50 INFO - PROCESS | 19834 | Values: 3067.3 3089.1 3107.3 3111.0 3127.2 5382.2 5389.9 5436.2 5553.7 5574.0 5364.6 5435.5 5500.6 5522.6 5534.0 4950.2 5018.2 5052.0 5066.7 5140.2 5071.5 5077.7 5113.6 5139.2 5139.8 4895.7 4956.1 4975.4 4977.8 5011.2 4973.6 4977.4 5061.5 5072.4 5091.4 4883.2 5006.2 5025.0 5030.2 5077.4 5433.2 5515.0 5528.8 5579.6 5626.5 5913.5 5919.4 5932.4 5944.0 5947.8 5741.9 5811.3 5885.6 5949.8 5991.3 5590.5 5596.5 5597.6 5601.7 5608.2 6044.1 6091.6 6101.0 6102.3 6110.5 5650.5 5747.8 5751.9 5787.2 5891.1 5983.7 5987.9 6001.2 6001.2 6002.2 5892.2 5919.3 5921.3 5933.5 5935.5 5758.7 5834.2 5845.7 5855.7 5944.1 4457.4 4497.0 4500.3 4500.7 4506.5 3953.0 3969.9 3998.0 4035.2 4062.0 5498.6 5526.7 5530.6 5557.5 5588.7 5960.4 5967.8 5969.1 5970.8 6003.1 5429.5 5467.2 5562.2 5574.5 5579.6 5017.1 5086.8 5089.3 5104.8 5146.4 6091.2 6094.7 6096.5 6103.5 6107.0 5723.3 5872.8 5907.5 5913.4 5925.0 6168.8 6181.9 6182.2 6195.5 6199.3 5873.4 5881.3 5882.4 5886.7 5932.8 5739.2 5794.1 5844.9 5989.6 5992.4 5775.5 5809.5 5817.2 5825.9 5852.4 5767.8 5775.2 5778.7 5780.4 5788.7 5568.6 5672.2 5676.3 5708.5 5752.9 5815.0 5815.2 5824.2 5875.2 5875.7 5602.3 5648.5 5654.5 5660.2 5662.2 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | [#1] ext.html Cycles:180 Average:50462.04 Median:42450.39 stddev:90465.97 (213.1%) stddev-sans-first:90642.22 19:36:50 INFO - PROCESS | 19834 | Values: 580.3 622.7 624.1 630.5 648.5 30871.2 31309.8 33823.3 33860.7 42546.0 40319.8 44798.8 45065.5 45075.5 45083.8 9025.5 9181.7 9184.2 9185.6 9191.6 8951.6 9022.4 9030.2 9037.8 9038.7 9090.9 9153.6 9170.7 9173.8 9177.7 9043.1 9058.9 9081.2 9088.7 9095.0 8865.5 8909.0 8933.3 8936.3 8949.7 41982.0 42477.0 42517.0 42529.6 42622.4 3487.0 3558.4 3682.4 3732.6 4072.2 33297.7 33394.0 33660.8 33671.7 35260.5 4461.6 4467.0 4515.6 4550.5 4630.4 374614.0 374762.0 375533.0 376209.0 378223.0 52596.5 58349.0 59596.0 60348.0 60887.7 64891.0 64987.4 65203.7 65225.0 65231.7 16868.6 17085.2 17091.9 17098.6 17101.9 12048.8 12841.7 13036.6 13041.7 13049.5 19626.9 19894.7 19942.1 20014.2 20068.5 7108.5 7191.6 7428.3 7433.9 7438.6 940.9 975.6 1024.7 1113.8 1160.6 33390.5 33686.8 34047.7 34252.7 34611.8 1115.1 1123.1 1142.2 1180.5 1197.8 17577.7 17812.9 17903.6 18011.6 18069.5 149777.0 150103.0 150146.2 150239.0 150351.0 58855.0 60183.0 60216.0 60348.4 60468.1 1230.8 1329.8 1367.2 1384.4 1401.7 32142.7 33879.3 34047.0 34460.7 34691.7 50120.0 50585.0 50679.0 50766.5 50789.5 429859.0 430659.0 431792.0 432375.0 432868.0 24905.3 27003.2 28295.3 28393.7 29690.4 43798.6 48811.5 49021.8 49153.3 50389.0 40911.6 42039.2 42423.8 43084.8 43739.6 41505.2 41667.4 42043.4 43087.8 43124.1 41944.6 42708.8 43123.0 43260.8 43274.1 35254.3 36870.9 37056.0 37588.2 38325.2 29056.7 29099.0 29179.7 29355.0 29452.1 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | [#2] jquery.html Cycles:180 Average:30609.41 Median:13665.95 stddev:87697.35 (641.7%) stddev-sans-first:87914.00 19:36:50 INFO - PROCESS | 19834 | Values: 389.5 389.7 399.3 399.8 413.5 18681.2 19209.8 19329.7 19567.3 20993.3 19086.0 19907.1 19916.0 19934.1 20602.3 5179.5 5241.9 5321.3 5324.1 5327.7 5232.7 5252.1 5257.4 5258.6 5276.0 5106.6 5284.0 5294.2 5300.8 5307.2 5234.7 5258.5 5275.9 5307.3 5308.1 5054.4 5181.8 5359.1 5367.4 5419.1 14024.6 14098.6 14127.2 23607.3 24788.1 2543.8 2610.0 2647.1 2754.4 3002.1 10315.2 10552.9 10790.7 11310.9 13050.1 1996.5 2020.1 2031.5 2040.0 2063.4 85662.6 86332.0 87450.9 87613.6 91849.5 11135.0 11317.7 11446.2 11534.3 12376.0 15688.0 15848.4 15850.1 15875.7 15880.0 8377.1 8379.6 8408.4 8482.4 8601.9 8167.7 8211.1 8251.7 8326.3 8401.9 4837.8 4846.9 4858.0 4900.3 4932.6 2006.7 2038.9 2045.3 2047.7 2053.4 1022.0 1040.8 1043.6 1066.5 1094.9 19851.7 19978.3 20750.6 21057.2 21512.6 969.4 1001.4 1015.4 1031.5 1035.3 10812.1 11478.8 11487.4 11488.9 11603.1 510745.0 528512.0 534323.0 536161.0 547513.0 82174.0 88812.0 100494.0 101763.0 103140.0 1003.1 1011.5 1044.0 1053.0 1069.6 18814.7 18827.9 18844.6 18914.6 19041.4 41664.6 43773.8 44321.6 44416.3 45059.0 61419.0 62654.7 62815.4 64015.4 64388.0 7827.3 8437.2 8649.9 8703.7 8773.3 9884.8 13776.0 14394.8 14656.0 14729.4 10003.3 12181.6 12204.9 12326.9 12389.3 10827.2 10840.5 11526.1 11877.8 12115.8 12602.0 12696.9 12770.6 12809.7 12942.9 8149.3 8163.3 8387.5 8432.6 8496.6 8456.4 8795.6 8821.5 8981.6 9572.6 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | [#3] mootools.html Cycles:180 Average:5968.14 Median:4885.78 stddev:3451.88 (70.7%) stddev-sans-first:3445.21 19:36:50 INFO - PROCESS | 19834 | Values: 1497.1 1498.8 1667.4 1794.2 1798.1 8718.6 9241.7 9315.0 9321.1 9333.8 7881.6 8419.5 8649.4 8671.4 9050.2 2357.0 2387.6 2389.4 2390.0 2391.5 2020.5 2347.7 2365.0 2366.4 2370.1 2192.7 2245.1 2256.6 2284.3 2289.3 2262.4 2290.6 2303.3 2307.6 2308.5 2244.1 2277.7 2281.7 2284.1 2293.5 9113.8 9213.6 9215.3 9218.5 9225.5 5236.1 5280.2 5287.2 5311.2 5427.8 3358.4 3461.5 3508.3 3537.7 3543.8 1175.1 1179.3 1195.6 1197.2 1218.9 12838.1 12848.3 12867.0 12873.4 12916.5 4537.6 4627.1 4772.8 4781.5 4826.0 10686.1 10702.7 10777.1 10787.7 10793.5 5413.3 5416.1 5419.3 5420.7 5431.9 4945.6 4981.2 4992.5 5010.1 5052.8 4122.5 4156.9 4202.8 4204.8 4244.1 1170.7 1270.4 1280.6 1292.6 1300.6 824.2 889.2 934.7 943.2 968.8 5695.5 6030.7 6072.4 6199.0 6334.6 928.8 929.8 955.7 962.6 1039.8 3964.8 4071.0 4115.3 4158.2 4184.3 10870.8 11199.6 11444.5 11572.4 11578.7 10687.7 11050.0 11098.4 11538.4 11547.8 8446.8 8523.9 8538.2 8563.4 8568.8 6052.2 6236.2 6267.5 6301.7 6302.2 10647.0 10679.9 10693.6 10787.7 10841.8 10473.2 10682.7 11011.2 11043.6 11148.6 8020.6 8066.0 8094.4 8101.6 8129.9 8577.9 8623.1 8675.6 8683.0 8726.0 7534.7 7538.4 7543.8 7624.3 7634.1 7868.2 7905.9 7989.8 8012.5 8045.7 7123.1 7181.5 7182.1 7184.5 7186.7 4996.5 5028.1 5064.0 5138.6 5184.7 5002.5 5013.3 5030.4 5294.7 5423.5 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | [#4] prototype.html Cycles:180 Average:4683.02 Median:5330.02 stddev:1358.49 (25.5%) stddev-sans-first:1322.15 19:36:50 INFO - PROCESS | 19834 | Values: 315.3 319.4 323.7 333.4 337.1 5274.8 5358.4 5369.8 5379.7 5383.7 5052.7 5187.0 5198.3 5207.0 5344.3 4059.2 4116.5 4199.0 4207.8 4217.6 4131.4 4157.8 4175.2 4188.7 4196.3 4071.3 4124.5 4134.6 4136.1 4177.7 4082.3 4085.5 4095.5 4126.0 4137.4 3657.0 3658.0 3661.0 3679.5 3699.5 5040.4 5160.6 5181.8 5199.8 5214.5 4741.0 4765.9 4775.7 4783.0 4788.7 5472.1 5487.5 5503.8 5520.8 5545.2 3976.4 4073.0 4078.6 4089.8 4091.3 5605.0 5641.6 5660.8 5669.2 5728.4 4167.1 4187.0 4193.4 4206.4 4212.3 4089.7 4235.2 4236.7 4252.9 4257.9 4725.7 4739.2 4752.9 4758.0 4788.7 5535.4 5598.7 5607.5 5613.0 5619.0 1321.4 1382.6 1432.9 1446.6 1451.9 996.2 1004.3 1008.8 1015.6 1019.6 5220.4 5283.9 5306.8 5324.9 5336.9 5590.6 5591.2 5592.7 5623.7 5634.7 5161.7 5335.2 5399.3 5411.4 5422.1 2940.9 2990.3 2997.9 3000.2 3004.9 5683.9 5853.6 5856.7 5859.9 5863.4 5767.5 5787.0 5791.2 5809.4 5815.7 5836.2 5837.7 5846.3 5863.8 5888.3 5440.1 5586.2 5651.2 5657.8 5660.3 5557.6 5559.3 5574.3 5584.8 5599.6 5578.8 5798.8 5826.0 5830.8 5904.0 4014.6 4116.5 4153.4 4162.3 4170.9 5612.9 5711.5 5734.0 5734.7 5830.4 5484.5 5536.9 5571.4 5572.4 5581.7 5270.7 5506.2 5517.2 5542.5 5568.1 5517.7 5540.8 5562.2 5564.0 5567.2 5597.9 5609.3 5616.2 5620.8 5645.9 5177.5 5475.9 5496.9 5499.7 5508.6 19:36:50 INFO - PROCESS | 19834 | 19:36:50 INFO - PROCESS | 19834 | [#5] yui.html Cycles:180 Average:21485.70 Median:3489.30 stddev:31144.35 (892.6%) stddev-sans-first:31192.59 19:36:50 INFO - PROCESS | 19834 | Values: 694.5 711.7 767.4 768.2 864.1 14181.1 15005.1 15107.2 15142.5 15159.3 15036.6 15237.6 15278.5 15292.9 15293.5 645.6 796.8 816.4 820.4 834.4 818.5 822.7 823.8 825.6 826.5 690.3 863.6 865.0 865.8 866.7 706.3 707.2 819.1 840.4 842.5 629.8 630.0 630.6 631.0 631.1 14841.9 14936.7 14971.3 14980.1 14996.2 14026.5 14296.9 14314.4 14429.7 14642.7 12445.6 12459.3 12510.4 12593.9 12646.6 4388.8 4407.8 4418.6 4459.9 4537.3 78565.0 78748.6 79005.0 79438.2 79639.6 10950.5 10967.5 10970.2 11098.6 11317.8 21735.3 21753.1 21756.1 21769.7 21788.7 8710.5 8744.7 8976.8 9011.5 9032.5 4779.5 4886.3 4907.6 5025.1 5178.1 3392.3 3477.7 3488.0 3490.6 3492.8 533.4 613.6 625.3 636.9 651.8 716.2 722.3 725.0 735.3 746.2 9640.8 10265.5 10336.5 10695.0 10941.0 595.4 683.3 711.4 721.7 726.0 4734.1 5069.6 5239.2 5279.5 5354.4 113371.0 123773.0 129269.4 130438.0 132808.0 98859.5 100349.0 101041.9 102455.5 103966.5 72760.3 72769.0 75189.6 87835.0 89879.6 10098.3 10164.5 10168.0 10168.9 10482.4 53031.6 53038.0 53113.7 53119.0 54464.5 73951.0 79775.0 80909.0 81223.6 81386.6 13149.7 13494.3 13510.6 13597.9 13614.7 14311.0 14631.8 14635.3 15170.7 15410.5 14061.0 14160.2 14397.6 14492.9 14744.7 14509.2 14640.5 14684.2 14732.2 15021.5 14368.2 14575.9 14972.6 15085.8 15099.0 11417.9 11440.0 11724.4 11891.2 11942.5 11496.0 11568.8 11902.2 12039.3 12179.5 19:36:50 INFO - PROCESS | 19834 | -------- Summary: end -------- 19:36:50 INFO - PROCESS | 19834 | 19:36:51 INFO - TEST-INFO | 19834: exit 0 19:36:51 INFO - TEST-OK | dromaeo_css | took 1113164ms 19:36:51 INFO - TEST-START | kraken 19:36:51 INFO - operating with platform_type : linux_ 19:36:51 INFO - Initialising browser for kraken test... 19:36:51 INFO - TEST-INFO | started process 20032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIsxRdI/profile http://localhost:45859/getInfo.html) 19:36:55 INFO - PROCESS | 20032 | __metrics Screen width/height:1600/1200 19:36:55 INFO - PROCESS | 20032 | colorDepth:24 19:36:55 INFO - PROCESS | 20032 | Browser inner width/height: 1024/697 19:36:55 INFO - PROCESS | 20032 | __metrics 19:36:56 INFO - PROCESS | 20032 | 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" 19:36:56 INFO - PROCESS | 20032 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:36:57 INFO - TEST-INFO | 20032: exit 0 19:36:57 INFO - Browser initialized. 19:36:57 INFO - Running cycle 1/1 for kraken test... 19:36:57 INFO - TEST-INFO | started process 20118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIsxRdI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:09 INFO - PROCESS | 20118 | RSS: Main: 157458432 19:37:09 INFO - PROCESS | 20118 | 19:37:11 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-beat-detection) 19:37:12 INFO - PROCESS | 20118 | RSS: Main: 215834624 19:37:12 INFO - PROCESS | 20118 | 19:37:15 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-dft) 19:37:15 INFO - PROCESS | 20118 | RSS: Main: 204087296 19:37:15 INFO - PROCESS | 20118 | 19:37:18 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-fft) 19:37:19 INFO - PROCESS | 20118 | RSS: Main: 269803520 19:37:19 INFO - PROCESS | 20118 | 19:37:21 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45859/tests/kraken/driver.html?testName=audio-oscillator) 19:37:21 INFO - PROCESS | 20118 | RSS: Main: 180510720 19:37:21 INFO - PROCESS | 20118 | 19:37:24 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:37:24 INFO - PROCESS | 20118 | RSS: Main: 184369152 19:37:24 INFO - PROCESS | 20118 | 19:37:27 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45859/tests/kraken/driver.html?testName=imaging-darkroom) 19:37:28 INFO - PROCESS | 20118 | RSS: Main: 220745728 19:37:28 INFO - PROCESS | 20118 | 19:37:31 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45859/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:32 INFO - PROCESS | 20118 | RSS: Main: 221655040 19:37:32 INFO - PROCESS | 20118 | 19:37:34 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45859/tests/kraken/driver.html?testName=json-parse-financial) 19:37:35 INFO - PROCESS | 20118 | RSS: Main: 221548544 19:37:35 INFO - PROCESS | 20118 | 19:37:37 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:37 INFO - PROCESS | 20118 | RSS: Main: 208441344 19:37:37 INFO - PROCESS | 20118 | 19:37:39 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:39 INFO - PROCESS | 20118 | RSS: Main: 209895424 19:37:40 INFO - PROCESS | 20118 | 19:37:41 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:42 INFO - PROCESS | 20118 | RSS: Main: 212332544 19:37:42 INFO - PROCESS | 20118 | 19:37:45 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:45 INFO - PROCESS | 20118 | RSS: Main: 225456128 19:37:45 INFO - PROCESS | 20118 | 19:37:48 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:49 INFO - PROCESS | 20118 | RSS: Main: 225419264 19:37:49 INFO - PROCESS | 20118 | 19:37:50 INFO - PROCESS | 20118 | Cycle 1(1): loaded http://localhost:45859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45859/tests/kraken/driver.html?testName=ai-astar) 19:37:50 INFO - PROCESS | 20118 | RSS: Main: 267943936 19:37:50 INFO - PROCESS | 20118 | 19:37:50 INFO - PROCESS | 20118 | __start_tp_report 19:37:50 INFO - PROCESS | 20118 | _x_x_mozilla_page_load 19:37:50 INFO - PROCESS | 20118 | _x_x_mozilla_page_load_details 19:37:50 INFO - PROCESS | 20118 | |i|pagename|runs| 19:37:50 INFO - PROCESS | 20118 | |0;ai-astar;101;112;109;109;110;110;113;110;110;109 19:37:50 INFO - PROCESS | 20118 | |1;audio-beat-detection;141;121;125;165;118;121;140;116;147;116 19:37:50 INFO - PROCESS | 20118 | |2;audio-dft;160;161;161;161;160;162;161;161;161;160 19:37:50 INFO - PROCESS | 20118 | |3;audio-fft;76;74;75;125;76;77;75;74;100;74 19:37:50 INFO - PROCESS | 20118 | |4;audio-oscillator;83;83;121;83;83;83;117;83;83;126 19:37:50 INFO - PROCESS | 20118 | |5;imaging-gaussian-blur;116;116;117;117;116;116;117;116;117;117 19:37:50 INFO - PROCESS | 20118 | |6;imaging-darkroom;147;147;146;147;146;146;146;147;146;146 19:37:50 INFO - PROCESS | 20118 | |7;imaging-desaturate;95;95;95;95;95;97;96;96;97;95 19:37:50 INFO - PROCESS | 20118 | |8;json-parse-financial;54;53;54;54;54;55;55;54;54;54 19:37:50 INFO - PROCESS | 20118 | |9;json-stringify-tinderbox;62;62;62;63;64;62;61;62;62;63 19:37:50 INFO - PROCESS | 20118 | |10;stanford-crypto-aes;81;75;75;76;80;83;75;75;84;85 19:37:50 INFO - PROCESS | 20118 | |11;stanford-crypto-ccm;119;126;130;118;127;118;128;116;173;128 19:37:50 INFO - PROCESS | 20118 | |12;stanford-crypto-pbkdf2;159;156;157;153;158;157;158;156;154;154 19:37:50 INFO - PROCESS | 20118 | |13;stanford-crypto-sha256-iterative;62;62;63;62;62;63;62;63;61;61 19:37:50 INFO - PROCESS | 20118 | __end_tp_report 19:37:50 INFO - PROCESS | 20118 | __start_cc_report 19:37:50 INFO - PROCESS | 20118 | _x_x_mozilla_cycle_collect,1656 19:37:50 INFO - PROCESS | 20118 | __end_cc_report 19:37:50 INFO - PROCESS | 20118 | __startTimestamp1468377470985__endTimestamp 19:37:50 INFO - PROCESS | 20118 | 19:37:50 INFO - PROCESS | 20118 | ------- Summary: start ------- 19:37:50 INFO - PROCESS | 20118 | Number of tests: 14 19:37:50 INFO - PROCESS | 20118 | 19:37:50 INFO - PROCESS | 20118 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.20 (2.9%) stddev-sans-first:1.39 19:37:50 INFO - PROCESS | 20118 | Values: 101.0 112.0 109.0 109.0 110.0 110.0 113.0 110.0 110.0 109.0 19:37:50 INFO - PROCESS | 20118 | 19:37:50 INFO - PROCESS | 20118 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:132.50 stddev:16.49 (12.4%) stddev-sans-first:17.09 19:37:50 INFO - PROCESS | 20118 | Values: 141.0 121.0 125.0 165.0 118.0 121.0 140.0 116.0 147.0 116.0 19:37:50 INFO - PROCESS | 20118 | 19:37:50 INFO - PROCESS | 20118 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 19:37:50 INFO - PROCESS | 20118 | Values: 160.0 161.0 161.0 161.0 160.0 162.0 161.0 161.0 161.0 160.0 19:37:50 INFO - PROCESS | 20118 | 19:37:50 INFO - PROCESS | 20118 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:16.85 (22.5%) stddev-sans-first:17.71 19:37:50 INFO - PROCESS | 20118 | Values: 76.0 74.0 75.0 125.0 76.0 77.0 75.0 74.0 100.0 74.0 19:37:50 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.00 stddev:18.64 (22.5%) stddev-sans-first:19.30 19:37:51 INFO - PROCESS | 20118 | Values: 83.0 83.0 121.0 83.0 83.0 83.0 117.0 83.0 83.0 126.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:37:51 INFO - PROCESS | 20118 | Values: 116.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:37:51 INFO - PROCESS | 20118 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 19:37:51 INFO - PROCESS | 20118 | Values: 95.0 95.0 95.0 95.0 95.0 97.0 96.0 96.0 97.0 95.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 19:37:51 INFO - PROCESS | 20118 | Values: 54.0 53.0 54.0 54.0 54.0 55.0 55.0 54.0 54.0 54.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 19:37:51 INFO - PROCESS | 20118 | Values: 62.0 62.0 62.0 63.0 64.0 62.0 61.0 62.0 62.0 63.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:80.50 stddev:4.15 (5.2%) stddev-sans-first:4.33 19:37:51 INFO - PROCESS | 20118 | Values: 81.0 75.0 75.0 76.0 80.0 83.0 75.0 75.0 84.0 85.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:127.50 stddev:16.53 (13.0%) stddev-sans-first:17.18 19:37:51 INFO - PROCESS | 20118 | Values: 119.0 126.0 130.0 118.0 127.0 118.0 128.0 116.0 173.0 128.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:157.00 stddev:1.99 (1.3%) stddev-sans-first:1.83 19:37:51 INFO - PROCESS | 20118 | Values: 159.0 156.0 157.0 153.0 158.0 157.0 158.0 156.0 154.0 154.0 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - PROCESS | 20118 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 19:37:51 INFO - PROCESS | 20118 | Values: 62.0 62.0 63.0 62.0 62.0 63.0 62.0 63.0 61.0 61.0 19:37:51 INFO - PROCESS | 20118 | -------- Summary: end -------- 19:37:51 INFO - PROCESS | 20118 | 19:37:51 INFO - TEST-INFO | 20118: exit 0 19:37:51 INFO - TEST-OK | kraken | took 60611ms 19:37:51 INFO - SUITE-END | took 1173s 19:37:52 INFO - Completed test suite (00:19:33) 19:37:52 INFO - javascript benchmark 19:37:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.3405217878158, 3089.135042188188, 3107.300857307106, 3111.0355789705177, 3127.2338277122108, 5382.2464854920345, 5389.892202155959, 5436.157395603678, 5553.694546799924, 5574.0, 5364.5708343332535, 5435.483629055233, 5500.6424582402215, 5522.641028333165, 5534.0, 4950.232713929347, 5018.222175562793, 5051.974740126313, 5066.74666266687, 5140.203268493389, 5071.518205770446, 5077.695338279696, 5113.565346945496, 5139.203423469368, 5139.768710408022, 4895.681780684262, 4956.132676781567, 4975.353204083446, 4977.776000079969, 5011.248312753098, 4973.552380285755, 4977.427595826454, 5061.544460998528, 5072.442031376546, 5091.389033315989, 4883.243097319921, 5006.249062640597, 5025.045241404122, 5030.220315851049, 5077.39071311445, 5433.239346491494, 5515.0, 5528.75120619573, 5579.609427340088, 5626.549876009909, 5913.526917846562, 5919.378465261172, 5932.436418540232, 5943.970280148615, 5947.791827286024, 5741.88516229673, 5811.27359080115, 5885.61743486672, 5949.821505354803, 5991.3109992351, 5590.496855283003, 5596.468335508121, 5597.552195824365, 5601.663900165962, 5608.2428872102155, 6044.1469977857205, 6091.573589848668, 6101.0, 6102.267727872595, 6110.51115910735, 5650.491455768918, 5747.770089196469, 5751.9424805751405, 5787.189793428924, 5891.057430811135, 5983.700814959235, 5987.9101813472835, 6001.159837622737, 6001.1898393717165, 6002.159697642333, 5892.234009578728, 5919.348871624118, 5921.3190483094995, 5933.465988061095, 5935.52515798735, 5758.683272420057, 5834.241548598655, 5845.7369418376275, 5855.707214639251, 5944.108383742473, 4457.353683715843, 4496.955030449719, 4500.257457519538, 4500.684952053325, 4506.549345065468, 3952.9524675960893, 3969.940450893239, 3997.960020399759, 4035.1929614077303, 4061.9796901015307, 5498.560115190775, 5526.696031718294, 5530.640508366943, 5557.499825015768, 5588.720563971785, 5960.433758792908, 5967.8209653710455, 5969.104634304802, 5970.820875373659, 6003.099535069775, 5429.457054294539, 5467.1799230115, 5562.16567514876, 5574.470425309589, 5579.637323573955, 5017.071841709296, 5086.821961231339, 5089.312942752755, 5104.821331253463, 5146.433892271847, 6091.177691011745, 6094.695265236721, 6096.512279017668, 6103.511719062464, 6107.0, 5723.3418156912485, 5872.794452194153, 5907.4683278505145, 5913.438223368945, 5924.9703751480965, 6168.814935551941, 6181.907271390843, 6182.165407669907, 6195.504359651127, 6199.318075011655, 5873.3832947539895, 5881.2942446906645, 5882.382349853204, 5886.705664716833, 5932.822015339547, 5739.167820665896, 5794.101914203306, 5844.912326315194, 5989.580729348903, 5992.370801065999, 5775.537956963517, 5809.477147056785, 5817.185594016925, 5825.854353641193, 5852.4147585241135, 5767.826965191051, 5775.220345253505, 5778.653280803165, 5780.421957804186, 5788.681622510802, 5568.55451563882, 5672.177534257427, 5676.347220069745, 5708.457696518824, 5752.942470575241, 5815.0, 5815.244018277597, 5824.21373114641, 5875.177475153397, 5875.676837773964, 5602.2717046783655, 5648.519875810438, 5654.46282603152, 5660.235868157746, 5662.150677398423], "value": 5441.270015208997, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.3297191743535, 622.7042154976386, 624.1012941364435, 630.4704048599176, 648.5298158834848, 30871.228219294502, 31309.843450782744, 33823.323533529314, 33860.66139338606, 42546.0, 40319.79840100795, 44798.77600612, 45065.549344506544, 45075.54924450754, 45083.77458112713, 9025.458472491671, 9181.724548263563, 9184.173424391836, 9185.632574697003, 9191.586378612978, 8951.552422378854, 9022.368434209608, 9030.187283144516, 9037.819243615124, 9038.728838134866, 9090.909090909105, 9153.63385464584, 9170.679026234084, 9173.816523669522, 9177.724668259963, 9043.140901614335, 9058.909410905939, 9081.182693557612, 9088.727338179866, 9095.0, 8865.46807191564, 8909.0, 8933.285337173076, 8936.285097192209, 8949.686760963335, 41982.0, 42477.0, 42517.0, 42529.57470425287, 42622.36066459006, 3487.0, 3558.395072837624, 3682.39240525313, 3732.5783103702756, 4072.165206132736, 33297.6670233297, 33394.0, 33660.83169584136, 33671.663283367096, 35260.47109293363, 4461.553844615545, 4467.0, 4515.593596576324, 4550.476695180064, 4630.351750754863, 374614.0, 374762.0, 375533.0, 376209.0, 378223.0, 52596.474035259926, 58349.0, 59596.0, 60348.0, 60887.69556152191, 64891.0, 64987.35012649908, 65203.673981629785, 65225.0, 65231.67384163049, 16868.57828554296, 17085.231164597622, 17091.914540427217, 17098.572535686708, 17101.91449042747, 12048.75902481963, 12841.678958025937, 13036.608901732963, 13041.673958150932, 13049.543265985645, 19626.90186549058, 19894.70157947632, 19942.10260538279, 20014.199432022557, 20068.498287542636, 7108.502404831612, 7191.64041797908, 7428.2571742825285, 7433.888491672629, 7438.6280685965485, 940.8776859008285, 975.6048800235916, 1024.7438140464883, 1113.7828123516, 1160.6417900782508, 33390.49914251288, 33686.83156584201, 34047.659523404946, 34252.65747342545, 34611.82694086513, 1115.1134847796022, 1123.1351859068473, 1142.2004596782285, 1180.474688763492, 1197.7724232395817, 17577.736333955, 17812.9109354455, 17903.552411189823, 18011.639767204582, 18069.457916262534, 149777.0, 150103.0, 150146.24926875514, 150239.0, 150351.0, 58855.0, 60183.0, 60216.0, 60348.39651603428, 60468.09297860535, 1230.809224570193, 1329.7739384304691, 1367.2480135925202, 1384.3908680180689, 1401.7336706025822, 32142.67857321397, 33879.3224135511, 34047.0, 34460.655393446745, 34691.65308346985, 50120.0, 50585.0, 50679.0, 50766.492335076175, 50789.492105078476, 429859.0, 430659.0, 431792.0, 432375.0, 432868.0, 24905.252842414757, 27003.1899043029, 28295.2926176839, 28393.716062839107, 29690.406191876475, 43798.56201437945, 48811.511884880696, 49021.75489122532, 49153.26270106023, 50389.0, 40911.59088409078, 42039.1592168161, 42423.787881060394, 43084.78457607692, 43739.56260437482, 41505.1698966025, 41667.37498937579, 42043.36934945917, 43087.784561076995, 43124.13751725011, 41944.580554194064, 42708.78645606877, 43123.0, 43260.783696081315, 43274.13451730885, 35254.29491410106, 36870.865976392306, 37056.0, 37588.248235034596, 38325.23349532938, 29056.709432906246, 29099.0, 29179.7082029177, 29355.0, 29452.116436506938], "value": 19777.755921298125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.47615457210077, 389.6960370910687, 399.28527934996356, 399.7681344820004, 413.48108124303997, 18681.159347829347, 19209.807901920994, 19329.71005434918, 19567.315143969965, 20993.265235716754, 19086.0, 19907.104180311886, 19916.0, 19934.102965366557, 20602.278920237793, 5179.533841954223, 5241.895162096746, 5321.308229930123, 5324.094903866333, 5327.653702509344, 5232.7383630818495, 5252.080885844962, 5257.36911570612, 5258.579313654917, 5276.0, 5106.64253502255, 5284.048871203182, 5294.179402192666, 5300.787968481275, 5307.177387504943, 5234.659747116425, 5258.526732594085, 5275.947240527584, 5307.2569840222395, 5308.071087559681, 5054.393472783289, 5181.844544663666, 5359.1425371940695, 5367.409584945653, 5419.105847535152, 14024.579262622137, 14098.647533811736, 14127.223002734845, 23607.29178124659, 24788.132415365555, 2543.771060604536, 2609.9869500652376, 2647.113217072283, 2754.352727109128, 3002.0993701889565, 10315.226358023177, 10552.894471055268, 10790.67627971162, 11310.886891131066, 13050.086493945428, 1996.4809149621058, 2020.1212472574477, 2031.4819720971207, 2040.0, 2063.432556047084, 85662.57168714178, 86332.0, 87450.93921712709, 87613.56193219057, 91849.54075229581, 11135.0, 11317.717057073474, 11446.198766086294, 11534.307941523535, 12376.0, 15688.0, 15848.366065357488, 15850.128242946517, 15875.682486350208, 15880.047197168207, 8377.078521362646, 8379.62291696875, 8408.369372297102, 8482.406231563855, 8601.870971935426, 8167.714130005421, 8211.137830527709, 8251.669933202726, 8326.250637442537, 8401.915980840113, 4837.830675926326, 4846.854594362175, 4857.95142048575, 4900.313956046157, 4932.580730637936, 2006.7491563554556, 2038.9490262743254, 2045.263705066175, 2047.7133201351824, 2053.404512691303, 1021.9948900255451, 1040.8126537223372, 1043.5512729526224, 1066.5200659703164, 1094.9178811589004, 19851.702224466644, 19978.30075947335, 20750.584988300452, 21057.157713691282, 21512.569748605252, 969.4183489906, 1001.4441984698562, 1015.4161357219629, 1031.4533297352416, 1035.30634474902, 10812.135029197645, 11478.770424591461, 11487.42562871853, 11488.88511114895, 11603.129765267639, 510745.0, 528512.0, 534323.0, 536161.0, 547513.0, 82174.0, 88812.0, 100494.0, 101763.0, 103140.0, 1003.0721582536125, 1011.4740335025892, 1044.0081922173813, 1052.952617132231, 1069.5882085397022, 18814.717779233597, 18827.90586047061, 18844.623107538046, 18914.621707566046, 19041.42875713731, 41664.583354167284, 43773.78113109541, 44321.55678443174, 44416.333754994346, 45059.0, 61419.0, 62654.68672656608, 62815.371846280956, 64015.35984640094, 64388.0, 7827.295543401121, 8437.156284371758, 8649.91350086491, 8703.695370661997, 8773.29813614922, 9884.802303954024, 13776.0, 14394.784078238625, 14655.974081814597, 14729.410823566937, 10003.34978226413, 12181.634550963485, 12204.938975305067, 12326.938365308117, 12389.256644601353, 10827.24209305341, 10840.457977100956, 11526.135539834713, 11877.82183267269, 12115.81826272589, 12601.991840652543, 12696.936515317364, 12770.61688149357, 12809.679758005752, 12942.935285323512, 8149.348052155695, 8163.306118979715, 8387.454815436977, 8432.578371081545, 8496.617652205789, 8456.365772566958, 8795.604197811243, 8821.514816685143, 8981.550922453982, 9572.617095316109], "value": 9320.130287429896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.1092200140915, 1498.8276348219954, 1667.374734474572, 1794.1567463292256, 1798.1189217283536, 8718.564071796409, 9241.722748317561, 9314.953425232872, 9321.114494123065, 9333.766655833599, 7881.566513841736, 8419.536925469112, 8649.437786543871, 8671.393002489829, 9050.1854833065, 2356.9764302357016, 2387.5821731197057, 2389.3787615219994, 2390.0439824070336, 2391.5336509380677, 2020.464576887126, 2347.7417484076736, 2364.959417856138, 2366.4320563064825, 2370.0756704885107, 2192.7368715754133, 2245.113180293783, 2256.571251462225, 2284.3375421127853, 2289.290320000805, 2262.3891549281766, 2290.6220473621834, 2303.262955854119, 2307.5500277445904, 2308.4805918668335, 2244.068711484732, 2277.7152855893014, 2281.7376001759676, 2284.1091974130104, 2293.483966107629, 9113.817723645556, 9213.585388657526, 9215.308851836073, 9218.539073046388, 9225.492597907112, 5236.083685355047, 5280.2079688046715, 5287.154055351164, 5311.229871668586, 5427.83716488506, 3358.395488812013, 3461.463473161664, 3508.3158784037123, 3537.6816086552076, 3543.7519373643854, 1175.1186610042469, 1179.262960649594, 1195.6413076077142, 1197.1978774221293, 1218.8598311194237, 12838.101332906606, 12848.293343866084, 12867.0, 12873.420696068606, 12916.547920822726, 4537.568930951555, 4627.074585082997, 4772.832950846704, 4781.521847815191, 4825.9758701206265, 10686.091682206945, 10702.73243168927, 10777.08394786452, 10787.730306742395, 10793.460326983777, 5413.296271484761, 5416.0521908666615, 5419.3225846769155, 5420.701861397582, 5431.864203394946, 4945.579625731782, 4981.178105612606, 4992.500749924979, 5010.098182327143, 5052.797888084509, 4122.546519882811, 4156.854510092132, 4202.831886724497, 4204.789760511962, 4244.087521182961, 1170.666360087388, 1270.371166272701, 1280.5715309148025, 1292.5799115287568, 1300.6423233610833, 824.1593574553922, 889.226373055446, 934.7055677461578, 943.2359788571142, 968.7527802216264, 5695.515881150066, 6030.728617212236, 6072.392760723892, 6199.0, 6334.5565810393755, 928.8049509603059, 929.7773427942369, 955.6607404371348, 962.5812771444444, 1039.8232300508932, 3964.781936993493, 4071.0, 4115.259253334429, 4158.189153115113, 4184.309588917795, 10870.836937445945, 11199.60801371948, 11444.54221831134, 11572.363520006313, 11578.71053223676, 10687.732806679895, 11050.0, 11098.389588572545, 11538.365389903636, 11547.769044619228, 8446.788830279169, 8523.872141917876, 8538.188872057144, 8563.357748168788, 8568.828623427496, 6052.152698622284, 6236.158118654105, 6267.529935254783, 6301.6534090625455, 6302.212223472066, 10647.041766240765, 10679.8932010682, 10693.625723099654, 10787.67636970892, 10841.837372439577, 10473.21450891171, 10682.679519614425, 11011.174161938046, 11043.558257669603, 11148.554057837595, 8020.558869262247, 8065.9596702016115, 8094.392920530866, 8101.594920253846, 8129.878051829109, 8577.914220857712, 8623.137686231326, 8675.566221688765, 8683.044865064712, 8726.040135585208, 7534.6609402578115, 7538.413170515071, 7543.7736867894055, 7624.27569380908, 7634.083909930844, 7868.173841746534, 7905.881411778943, 7989.8402031960195, 8012.479188852939, 8045.678172873019, 7123.145222573325, 7181.497295189287, 7182.138143422822, 7184.533005354635, 7186.748463803742, 4996.475370086234, 5028.069807085701, 5063.974680126576, 5138.614603904647, 5184.662996905189, 5002.499750024968, 5013.348264725562, 5030.4466508684745, 5294.655847369909, 5423.484768946943], "value": 4741.396521855412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.33936403235214, 319.3692457396641, 323.65854024004665, 333.4098645397645, 337.0797722218344, 5274.762635681394, 5358.383785864627, 5369.791796845708, 5379.704116273609, 5383.67697938124, 5052.696838189711, 5187.0, 5198.324217851674, 5206.973965130179, 5344.331958505187, 4059.167870586523, 4116.506019277691, 4198.958010419902, 4207.8007767786185, 4217.578242175773, 4131.380292956051, 4157.771322577257, 4175.185838761443, 4188.6649068074485, 4196.265653510639, 4071.2875246831836, 4124.546299907008, 4134.586541345856, 4136.084060737173, 4177.7284476509085, 4082.3060079786505, 4085.529209484583, 4095.5494895561465, 4125.958740412588, 4137.40007698885, 3656.9943265601905, 3658.0, 3661.0, 3679.4664773607947, 3699.500567423417, 5040.42035165957, 5160.56135228506, 5181.792728290864, 5199.766010529497, 5214.504622060898, 4740.95259047412, 4765.928511072337, 4775.689580177312, 4783.0, 4788.736619485927, 5472.1244600864065, 5487.478689524529, 5503.7798488060425, 5520.7854272060085, 5545.223668686387, 3976.403539469074, 4072.9796351018354, 4078.5513593504693, 4089.8364065437345, 4091.345384738457, 5604.999999999959, 5641.576881733887, 5660.773569057233, 5669.177969194444, 5728.369879313273, 4167.1457351242925, 4187.0, 4193.433886425354, 4206.432131662247, 4212.262854000538, 4089.734167279117, 4235.152969406069, 4236.724612900213, 4252.936205956913, 4257.914841703148, 4725.69282996611, 4739.218029025173, 4752.881177970578, 4757.95242047582, 4788.712677239377, 5535.391106978229, 5598.692071936001, 5607.467290607386, 5612.97193514038, 5619.00525313516, 1321.447299423193, 1382.5990462765888, 1432.9355179016968, 1446.5534465534465, 1451.903812621464, 996.2279233594022, 1004.2869562610482, 1008.7642637768674, 1015.6491865818443, 1019.56158851693, 5220.389805097451, 5283.947160528345, 5306.7611957462, 5324.866878327995, 5336.91994620081, 5590.580706446952, 5591.217229587861, 5592.692401917852, 5623.662580245198, 5634.690092044977, 5161.716105614228, 5335.1730481775385, 5399.298091248191, 5411.431799660979, 5422.078246698071, 2940.8823647053878, 2990.2524368907775, 2997.925051873721, 3000.1899487138785, 3004.9248768780953, 5683.886322273532, 5853.590248682636, 5856.652969816966, 5859.94140058594, 5863.355030946593, 5767.509761670305, 5786.987277226469, 5791.160281759121, 5809.390014048548, 5815.73829177688, 5836.153757705109, 5837.737301821513, 5846.2692163480415, 5863.765449382062, 5888.263967004124, 5440.0959664117245, 5586.217929489956, 5651.237082993744, 5657.840142770639, 5660.320761508646, 5557.555395568425, 5559.305086864142, 5574.293095091719, 5584.832455026356, 5599.612234598009, 5578.832635020955, 5798.782255726344, 5825.970870145622, 5830.76676932918, 5904.0, 4014.578469260802, 4116.485439320085, 4153.356229784388, 4162.250794856955, 4170.937435938524, 5612.85967850807, 5711.485966263056, 5734.0, 5734.7132643368495, 5830.358660547252, 5484.464349982011, 5536.889262214814, 5571.387147413862, 5572.442755724395, 5581.6930068846605, 5270.683758974474, 5506.174073888948, 5517.172424136412, 5542.528885044816, 5568.1091025435735, 5517.724113794214, 5540.75066622011, 5562.165675148598, 5564.0, 5567.220589117608, 5597.860053498695, 5609.270794796814, 5616.1856530803625, 5620.831375058755, 5645.943540564542, 5177.4822517747925, 5475.863103422446, 5496.862578435571, 5499.670019798825, 5508.614396992172], "value": 4250.258431553422, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.5207806613433, 711.690414669619, 767.3784234769837, 768.1962771263107, 864.0927026622045, 14181.078229915061, 15005.099694018367, 15107.169105699182, 15142.470013549528, 15159.317830697604, 15036.624084397896, 15237.619059523517, 15278.465253716095, 15292.923535382335, 15293.464728734496, 645.5835985789163, 796.7569891183186, 816.3754727633366, 820.409305300183, 834.4117397234935, 818.5007145641155, 822.7202751064636, 823.7816978500703, 825.6449726617582, 826.4958375391006, 690.3441730356157, 863.641588740675, 865.03548543374, 865.8441480533502, 866.7399780065987, 706.2760670312945, 707.1584814071265, 819.1439945257191, 840.3949156607295, 842.4860834890711, 629.7984644913629, 630.0171732097942, 630.6090224061112, 630.9936900631027, 631.1290419221491, 14841.925790371088, 14936.70126597462, 14971.251437428085, 14980.1011939284, 14996.175210363426, 14026.509072182527, 14296.857031429761, 14314.355853986492, 14429.71140577193, 14642.707145857023, 12445.564405245774, 12459.314737689423, 12510.437030333565, 12593.93703031479, 12646.620601381974, 4388.824447022147, 4407.801648925806, 4418.5581441855875, 4459.910801783946, 4537.31940208968, 78565.0, 78748.60625696892, 79005.0, 79438.20561794423, 79639.60180199062, 10950.507227174796, 10967.50646220922, 10970.177236707279, 11098.61154859576, 11317.83023254652, 21735.347939561838, 21753.12987480515, 21756.12975480963, 21769.673454898188, 21788.673169902464, 8710.520921349387, 8744.737657870273, 8976.775580610407, 9011.504367259864, 9032.45805251687, 4779.545943135397, 4886.340344053508, 4907.607391408679, 5025.095482813055, 5178.093833579109, 3392.3384939936477, 3477.7043951264427, 3488.0, 3490.5985811631986, 3492.7904325740537, 533.3812777178455, 613.5858295650418, 625.2902955145942, 636.9426751592379, 651.7718798420515, 716.183550752143, 722.2705067881477, 725.0, 735.3051366458645, 746.220199891115, 9640.75898102539, 10265.486725663686, 10336.5348559315, 10694.983976522219, 10941.0, 595.3808039638814, 683.3439897698166, 711.416638356553, 721.6788529104498, 726.0307489501469, 4734.147853386355, 5069.569086627678, 5239.161734122522, 5279.52484276417, 5354.437784032621, 113371.0, 123773.0, 129269.35365323113, 130438.0, 132808.0, 98859.50570247247, 100349.0, 101041.87497500348, 102455.48772256241, 103966.4801676002, 72760.2723972764, 72769.0, 75189.62405188048, 87835.0, 89879.55060224657, 10098.343607665773, 10164.539289988152, 10168.034036766496, 10168.898311016796, 10482.423466709404, 53031.63620365426, 53038.0, 53113.7344313276, 53119.0, 54464.45535544594, 73951.0, 79775.0, 80909.0, 81223.59388203258, 81386.59306703428, 13149.671258218621, 13494.32528373597, 13510.594682159552, 13597.932010339884, 13614.727705446034, 14311.0, 14631.780523292373, 14635.268236587915, 15170.696586068438, 15410.537683869501, 14061.0, 14160.150390976574, 14397.64005899861, 14492.927535362256, 14744.705105898036, 14509.201993890438, 14640.487582934973, 14684.192369419785, 14732.189729564976, 15021.549353519413, 14368.209748463934, 14575.927120364755, 14972.625684357978, 15085.773713394527, 15099.0, 11417.885821141683, 11440.0, 11724.355160465915, 11891.227070240408, 11942.522299108286, 11496.0, 11568.768624627292, 11902.166848320534, 12039.33783641873, 12179.512819487121], "value": 7742.532946135488, "unit": "score"}], "name": "dromaeo_css", "value": 7341.044726619274, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 109.0, 109.0, 110.0, 110.0, 113.0, 110.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 121.0, 125.0, 165.0, 118.0, 121.0, 140.0, 116.0, 147.0, 116.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 125.0, 76.0, 77.0, 75.0, 74.0, 100.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 121.0, 83.0, 83.0, 83.0, 117.0, 83.0, 83.0, 126.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 97.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 62.0, 61.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 75.0, 76.0, 80.0, 83.0, 75.0, 75.0, 84.0, 85.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 126.0, 130.0, 118.0, 127.0, 118.0, 128.0, 116.0, 173.0, 128.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 157.0, 153.0, 158.0, 157.0, 158.0, 156.0, 154.0, 154.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 61.0, 61.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1478.6000000000001, "alertThreshold": 2.0}]} 19:37:52 INFO - Return code: 0 19:37:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:37:52 INFO - # TBPL SUCCESS # 19:37:52 INFO - Running post-action listener: _resource_record_post_action 19:37:52 INFO - ##### 19:37:52 INFO - ##### Finished run-tests step (success) 19:37:52 INFO - ##### 19:37:52 INFO - Running post-run listener: _resource_record_post_run 19:37:52 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553914368; Read time: 8; Write time: 360560 19:37:52 INFO - TinderboxPrint: CPU usage
12.9% 19:37:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:37:52 INFO - TinderboxPrint: I/O write bytes / time
553,914,368 / 360,560 19:37:52 INFO - TinderboxPrint: CPU idle
8,277.3 (87.1%) 19:37:52 INFO - TinderboxPrint: CPU user
1,187.3 (12.5%) 19:37:52 INFO - TinderboxPrint: Swap in / out
0 / 0 19:37:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 263249920; Read time: 0; Write time: 188244 19:37:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 290664448; Read time: 0; Write time: 172316 19:37:52 INFO - Running post-run listener: _upload_blobber_files 19:37:52 INFO - Blob upload gear active. 19:37:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:37:52 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 19:37:52 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'] 19:37:52 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 19:37:53 INFO - (blobuploader) - INFO - Open directory for files ... 19:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:54 INFO - (blobuploader) - INFO - Done attempting. 19:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:54 INFO - (blobuploader) - INFO - Done attempting. 19:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:37:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:58 INFO - (blobuploader) - INFO - Done attempting. 19:37:58 INFO - (blobuploader) - INFO - Iteration through files over. 19:37:58 INFO - Return code: 0 19:37:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:37:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:37:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92c6ac2063011695d6f455c152490e3008b4551bd2c5fff79c446ce9f7b3d0fb4fbd7e855fc7a3d36ff6e78d5c0e3bf36b26d53fb9f0fe28dec875274c3ee1a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb0c8704e3337eca5a59b6cdfb5f96ac6f6de0dec2f1372e44bb7d9d96b04dabcb4c07fc4af5b3c76ce483897110594a2fe2d660f299ebc3eef0edc9e20f06a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32f0d1461b1d4351024e645e2aaeb62a976cd1145da0c477cdb96f8a18aa45656a9b5737e0bf405dd5a2b35fdfaf271884e50957d18fd7a56ce2624f81913208"} 19:37:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:37:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:37:58 INFO - Contents: 19:37:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92c6ac2063011695d6f455c152490e3008b4551bd2c5fff79c446ce9f7b3d0fb4fbd7e855fc7a3d36ff6e78d5c0e3bf36b26d53fb9f0fe28dec875274c3ee1a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb0c8704e3337eca5a59b6cdfb5f96ac6f6de0dec2f1372e44bb7d9d96b04dabcb4c07fc4af5b3c76ce483897110594a2fe2d660f299ebc3eef0edc9e20f06a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32f0d1461b1d4351024e645e2aaeb62a976cd1145da0c477cdb96f8a18aa45656a9b5737e0bf405dd5a2b35fdfaf271884e50957d18fd7a56ce2624f81913208"} 19:37:58 INFO - Running post-run listener: copy_logs_to_upload_dir 19:37:58 INFO - Copying logs to upload dir... 19:37:58 INFO - mkdir: /builds/slave/test/build/upload/logs 19:37:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.170544 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-12 19:37:58.089179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:37:58.092669) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804 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/92c6ac2063011695d6f455c152490e3008b4551bd2c5fff79c446ce9f7b3d0fb4fbd7e855fc7a3d36ff6e78d5c0e3bf36b26d53fb9f0fe28dec875274c3ee1a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb0c8704e3337eca5a59b6cdfb5f96ac6f6de0dec2f1372e44bb7d9d96b04dabcb4c07fc4af5b3c76ce483897110594a2fe2d660f299ebc3eef0edc9e20f06a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32f0d1461b1d4351024e645e2aaeb62a976cd1145da0c477cdb96f8a18aa45656a9b5737e0bf405dd5a2b35fdfaf271884e50957d18fd7a56ce2624f81913208"} build_url:https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/dVV6kjT8RjGFQjlhC-YxNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92c6ac2063011695d6f455c152490e3008b4551bd2c5fff79c446ce9f7b3d0fb4fbd7e855fc7a3d36ff6e78d5c0e3bf36b26d53fb9f0fe28dec875274c3ee1a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb0c8704e3337eca5a59b6cdfb5f96ac6f6de0dec2f1372e44bb7d9d96b04dabcb4c07fc4af5b3c76ce483897110594a2fe2d660f299ebc3eef0edc9e20f06a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32f0d1461b1d4351024e645e2aaeb62a976cd1145da0c477cdb96f8a18aa45656a9b5737e0bf405dd5a2b35fdfaf271884e50957d18fd7a56ce2624f81913208"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:37:58.117501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:37:58.117789) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1468375818.688375-884249804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:37:58.201006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:37:58.201334) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:37:58.201616) ========= ========= Total master_lag: 0.17 =========