builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1467183717.92 results: success (0) buildid: 20160628230027 builduid: cf7826aee2944d4a907696430d07c214 revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:57.917202) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:57.917674) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:57.918054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:58.130539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:58.130922) ========= 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=0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 00:01:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.4M=0s 2016-06-29 00:01:59 (96.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201414 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:58.346926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:58.347276) ========= 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=0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016044 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:58.396925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:58.397291) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1af8a633527ae1c95bf0e630a75f9810be3995d --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 e1af8a633527ae1c95bf0e630a75f9810be3995d --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=0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 00:01:59,190 truncating revision to first 12 chars 2016-06-29 00:01:59,190 Setting DEBUG logging. 2016-06-29 00:01:59,191 attempt 1/10 2016-06-29 00:01:59,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1af8a633527?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 00:01:59,502 unpacking tar archive at: fx-team-e1af8a633527/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:59.085840) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:59.086443) ========= script_repo_revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:59.087206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:59.087545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 00:01:59.098098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-29 00:01:59.098737) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:01:59 INFO - MultiFileLogger online at 20160629 00:01:59 in /builds/slave/test 00:01:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:01:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:01:59 INFO - {'append_to_log': False, 00:01:59 INFO - 'base_work_dir': '/builds/slave/test', 00:01:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:01:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:01:59 INFO - 'branch': 'Fx-Team-Non-PGO', 00:01:59 INFO - 'buildbot_json_path': 'buildprops.json', 00:01:59 INFO - 'config_files': ('talos/linux_config.py',), 00:01:59 INFO - 'default_actions': ('clobber', 00:01:59 INFO - 'read-buildbot-config', 00:01:59 INFO - 'download-and-extract', 00:01:59 INFO - 'populate-webroot', 00:01:59 INFO - 'create-virtualenv', 00:01:59 INFO - 'install', 00:01:59 INFO - 'run-tests'), 00:01:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:01:59 INFO - 'download_minidump_stackwalk': True, 00:01:59 INFO - 'download_symbols': 'ondemand', 00:01:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:01:59 INFO - 'tooltool.py': '/tools/tooltool.py', 00:01:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:01:59 INFO - '/tools/misc-python/virtualenv.py')}, 00:01:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:01:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:01:59 INFO - 'installer_path': 'installer.exe', 00:01:59 INFO - 'log_level': 'info', 00:01:59 INFO - 'log_name': 'talos', 00:01:59 INFO - 'log_to_console': True, 00:01:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:01:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:01:59 INFO - 'opt_config_files': (), 00:01:59 INFO - 'pip_index': False, 00:01:59 INFO - 'sps_profile': False, 00:01:59 INFO - 'sps_profile_interval': 0, 00:01:59 INFO - 'suite': 'dromaeojs-e10s', 00:01:59 INFO - 'system_bits': '32', 00:01:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:01:59 INFO - 'title': 'talos-linux64-ix-017', 00:01:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:01:59 INFO - 'use_talos_json': True, 00:01:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:01:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:01:59 INFO - 'work_dir': 'build'} 00:01:59 INFO - ##### 00:01:59 INFO - ##### Running clobber step. 00:01:59 INFO - ##### 00:01:59 INFO - Running pre-action listener: _resource_record_pre_action 00:01:59 INFO - Running main action method: clobber 00:01:59 INFO - rmtree: /builds/slave/test/build 00:01:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:02:00 INFO - Running post-action listener: _resource_record_post_action 00:02:00 INFO - ##### 00:02:00 INFO - ##### Finished clobber step (success) 00:02:00 INFO - ##### 00:02:00 INFO - ##### 00:02:00 INFO - ##### Running read-buildbot-config step. 00:02:00 INFO - ##### 00:02:00 INFO - Running pre-action listener: _resource_record_pre_action 00:02:00 INFO - Running main action method: read_buildbot_config 00:02:00 INFO - Using buildbot properties: 00:02:00 INFO - { 00:02:00 INFO - "project": "", 00:02:00 INFO - "product": "firefox", 00:02:00 INFO - "script_repo_revision": "production", 00:02:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:02:00 INFO - "repository": "", 00:02:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:02:00 INFO - "buildid": "20160628230027", 00:02:00 INFO - "pgo_build": "False", 00:02:00 INFO - "basedir": "/builds/slave/test", 00:02:00 INFO - "buildnumber": 1623, 00:02:00 INFO - "slavename": "talos-linux64-ix-017", 00:02:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:02:00 INFO - "platform": "ubuntu64_hw", 00:02:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:02:00 INFO - "branch": "fx-team", 00:02:00 INFO - "repo_path": "integration/fx-team", 00:02:00 INFO - "revision": "e1af8a633527ae1c95bf0e630a75f9810be3995d", 00:02:00 INFO - "stage_platform": "linux64", 00:02:00 INFO - "builduid": "cf7826aee2944d4a907696430d07c214", 00:02:00 INFO - "slavebuilddir": "test" 00:02:00 INFO - } 00:02:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:02:00 INFO - Running post-action listener: _resource_record_post_action 00:02:00 INFO - ##### 00:02:00 INFO - ##### Finished read-buildbot-config step (success) 00:02:00 INFO - ##### 00:02:00 INFO - ##### 00:02:00 INFO - ##### Running download-and-extract step. 00:02:00 INFO - ##### 00:02:00 INFO - Running pre-action listener: _resource_record_pre_action 00:02:00 INFO - Running main action method: download_and_extract 00:02:00 INFO - mkdir: /builds/slave/test/build/tests 00:02: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')]} 00:02:00 INFO - https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:01 INFO - Downloaded 1361 bytes. 00:02:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:02:01 INFO - Using the following test package requirements: 00:02:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:02:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:02:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:02:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'jsshell-linux-x86_64.zip'], 00:02:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:02:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:02:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:02:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:02:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:02:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:02:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:02:01 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')]} 00:02:01 INFO - https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:02 INFO - Downloaded 22700123 bytes. 00:02:02 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'] 00:02:02 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 00:02:04 INFO - Return code: 0 00:02:04 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 00:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:04 INFO - https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:05 INFO - Downloaded 22700123 bytes. 00:02:05 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'] 00:02:05 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 00:02:06 INFO - Return code: 0 00:02:06 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')]} 00:02:06 INFO - https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:02:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:02:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:02:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:07 INFO - Downloaded 14405245 bytes. 00:02:07 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'] 00:02:07 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 00:02:08 INFO - Return code: 0 00:02:08 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')]} 00:02:08 INFO - https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:02:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:02:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:02:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bxEmz13SSuC0XLVX_wcucw/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 00:02:09 INFO - Downloaded 56463805 bytes. 00:02:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:02:09 INFO - mkdir: /builds/slave/test/properties 00:02:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:02:09 INFO - Writing to file /builds/slave/test/properties/build_url 00:02:09 INFO - Contents: 00:02:09 INFO - build_url:https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:02:10 INFO - Running post-action listener: _resource_record_post_action 00:02:10 INFO - Running post-action listener: set_extra_try_arguments 00:02:10 INFO - ##### 00:02:10 INFO - ##### Finished download-and-extract step (success) 00:02:10 INFO - ##### 00:02:10 INFO - ##### 00:02:10 INFO - ##### Running populate-webroot step. 00:02:10 INFO - ##### 00:02:10 INFO - Running pre-action listener: _resource_record_pre_action 00:02:10 INFO - Running main action method: populate_webroot 00:02:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:02:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:02:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:02:10 INFO - '--tppagecycles', 00:02:10 INFO - '7'], 00:02:10 INFO - 'tests': ['tsvgm']}}, 00:02:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:02:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:02:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:02:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:02:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:02:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:02:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['damp', 'tps']}, 00:02:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'tests': ['damp', 'tps']}, 00:02:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['dromaeo_dom']}, 00:02:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:02:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['basic_compositor_video']}, 00:02:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:02:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['a11yr', 00:02:10 INFO - 'ts_paint', 00:02:10 INFO - 'tpaint', 00:02:10 INFO - 'sessionrestore', 00:02:10 INFO - 'sessionrestore_no_auto_restore', 00:02:10 INFO - 'tabpaint']}, 00:02:10 INFO - 'other-e10s': {'tests': ['a11yr', 00:02:10 INFO - 'ts_paint', 00:02:10 INFO - 'tpaint', 00:02:10 INFO - 'sessionrestore', 00:02:10 INFO - 'sessionrestore_no_auto_restore', 00:02:10 INFO - 'tabpaint']}, 00:02:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:02:10 INFO - 'ts_paint', 00:02:10 INFO - 'tpaint', 00:02:10 INFO - 'sessionrestore', 00:02:10 INFO - 'sessionrestore_no_auto_restore', 00:02:10 INFO - 'tabpaint']}, 00:02:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:02:10 INFO - 'ts_paint', 00:02:10 INFO - 'tpaint', 00:02:10 INFO - 'sessionrestore', 00:02:10 INFO - 'sessionrestore_no_auto_restore', 00:02:10 INFO - 'tabpaint']}, 00:02:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['a11yr', 00:02:10 INFO - 'ts_paint', 00:02:10 INFO - 'tpaint', 00:02:10 INFO - 'sessionrestore', 00:02:10 INFO - 'sessionrestore_no_auto_restore', 00:02:10 INFO - 'tabpaint']}, 00:02:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['a11yr', 00:02:10 INFO - 'ts_paint', 00:02:10 INFO - 'tpaint', 00:02:10 INFO - 'sessionrestore', 00:02:10 INFO - 'sessionrestore_no_auto_restore', 00:02:10 INFO - 'tabpaint']}, 00:02:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['tsvgx', 00:02:10 INFO - 'tsvgr_opacity', 00:02:10 INFO - 'tart', 00:02:10 INFO - 'tscrollx', 00:02:10 INFO - 'cart']}, 00:02:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:02:10 INFO - 'tsvgr_opacity', 00:02:10 INFO - 'tart', 00:02:10 INFO - 'tscrollx', 00:02:10 INFO - 'cart']}, 00:02:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'talos_options': ['--disable-e10s'], 00:02:10 INFO - 'tests': ['tp5o']}, 00:02:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'tests': ['tp5o']}, 00:02:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'talos_options': ['--disable-e10s', 00:02:10 INFO - '--xperf_path', 00:02:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:02:10 INFO - 'tests': ['tp5n']}, 00:02:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:10 INFO - 'talos_options': ['--xperf_path', 00:02:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:02:10 INFO - 'tests': ['tp5n']}}, 00:02:10 INFO - 'talos.zip': {'path': '', 00:02:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:02:10 INFO - Running post-action listener: _resource_record_post_action 00:02:10 INFO - ##### 00:02:10 INFO - ##### Finished populate-webroot step (success) 00:02:10 INFO - ##### 00:02:10 INFO - ##### 00:02:10 INFO - ##### Running create-virtualenv step. 00:02:10 INFO - ##### 00:02:10 INFO - Running pre-action listener: _resource_record_pre_action 00:02:10 INFO - Running main action method: create_virtualenv 00:02:10 INFO - Creating virtualenv /builds/slave/test/build/venv 00:02:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:02:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:02:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:02:10 INFO - Using real prefix '/usr' 00:02:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:02:10 INFO - Installing distribute.............................................................................................................................................................................................done. 00:02:12 INFO - Installing pip.................done. 00:02:12 INFO - Return code: 0 00:02:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:02:12 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')]} 00:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:12 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')]} 00:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:12 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 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:02:12 INFO - Using env: {'DISPLAY': ':0', 00:02:12 INFO - 'HOME': '/home/cltbld', 00:02:12 INFO - 'LANG': 'en_US.UTF-8', 00:02:12 INFO - 'LANGUAGE': 'en_US:en', 00:02:12 INFO - 'LOGNAME': 'cltbld', 00:02:12 INFO - 'MAIL': '/var/mail/cltbld', 00:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:12 INFO - 'MOZ_NO_REMOTE': '1', 00:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:12 INFO - 'NO_EM_RESTART': '1', 00:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:12 INFO - 'PWD': '/builds/slave/test', 00:02:12 INFO - 'SHELL': '/bin/bash', 00:02:12 INFO - 'SHLVL': '1', 00:02:12 INFO - 'TERM': 'linux', 00:02:12 INFO - 'TMOUT': '86400', 00:02:12 INFO - 'USER': 'cltbld', 00:02:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:12 INFO - '_': '/tools/buildbot/bin/python'} 00:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:02:13 INFO - Cleaning up... 00:02:13 INFO - Return code: 0 00:02:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:02:13 INFO - Using env: {'DISPLAY': ':0', 00:02:13 INFO - 'HOME': '/home/cltbld', 00:02:13 INFO - 'LANG': 'en_US.UTF-8', 00:02:13 INFO - 'LANGUAGE': 'en_US:en', 00:02:13 INFO - 'LOGNAME': 'cltbld', 00:02:13 INFO - 'MAIL': '/var/mail/cltbld', 00:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:13 INFO - 'MOZ_NO_REMOTE': '1', 00:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:13 INFO - 'NO_EM_RESTART': '1', 00:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:13 INFO - 'PWD': '/builds/slave/test', 00:02:13 INFO - 'SHELL': '/bin/bash', 00:02:13 INFO - 'SHLVL': '1', 00:02:13 INFO - 'TERM': 'linux', 00:02:13 INFO - 'TMOUT': '86400', 00:02:13 INFO - 'USER': 'cltbld', 00:02:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:13 INFO - '_': '/tools/buildbot/bin/python'} 00:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:13 INFO - Downloading/unpacking psutil>=3.1.1 00:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:02:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:02:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:02:15 INFO - Installing collected packages: psutil 00:02:15 INFO - Running setup.py install for psutil 00:02:15 INFO - building 'psutil._psutil_linux' extension 00:02:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:02:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:02:15 INFO - building 'psutil._psutil_posix' extension 00:02:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:02:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:02:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:02:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:02:15 INFO - Successfully installed psutil 00:02:15 INFO - Cleaning up... 00:02:15 INFO - Return code: 0 00:02:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:02:15 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')]} 00:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:15 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')]} 00:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:15 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 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:02:15 INFO - Using env: {'DISPLAY': ':0', 00:02:15 INFO - 'HOME': '/home/cltbld', 00:02:15 INFO - 'LANG': 'en_US.UTF-8', 00:02:15 INFO - 'LANGUAGE': 'en_US:en', 00:02:15 INFO - 'LOGNAME': 'cltbld', 00:02:15 INFO - 'MAIL': '/var/mail/cltbld', 00:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:15 INFO - 'MOZ_NO_REMOTE': '1', 00:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:15 INFO - 'NO_EM_RESTART': '1', 00:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:15 INFO - 'PWD': '/builds/slave/test', 00:02:15 INFO - 'SHELL': '/bin/bash', 00:02:15 INFO - 'SHLVL': '1', 00:02:15 INFO - 'TERM': 'linux', 00:02:15 INFO - 'TMOUT': '86400', 00:02:15 INFO - 'USER': 'cltbld', 00:02:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:15 INFO - '_': '/tools/buildbot/bin/python'} 00:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:02:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:02:17 INFO - Installing collected packages: mozsystemmonitor 00:02:17 INFO - Running setup.py install for mozsystemmonitor 00:02:18 INFO - Successfully installed mozsystemmonitor 00:02:18 INFO - Cleaning up... 00:02:18 INFO - Return code: 0 00:02:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:02:18 INFO - Using env: {'DISPLAY': ':0', 00:02:18 INFO - 'HOME': '/home/cltbld', 00:02:18 INFO - 'LANG': 'en_US.UTF-8', 00:02:18 INFO - 'LANGUAGE': 'en_US:en', 00:02:18 INFO - 'LOGNAME': 'cltbld', 00:02:18 INFO - 'MAIL': '/var/mail/cltbld', 00:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:18 INFO - 'MOZ_NO_REMOTE': '1', 00:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:18 INFO - 'NO_EM_RESTART': '1', 00:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:18 INFO - 'PWD': '/builds/slave/test', 00:02:18 INFO - 'SHELL': '/bin/bash', 00:02:18 INFO - 'SHLVL': '1', 00:02:18 INFO - 'TERM': 'linux', 00:02:18 INFO - 'TMOUT': '86400', 00:02:18 INFO - 'USER': 'cltbld', 00:02:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:18 INFO - '_': '/tools/buildbot/bin/python'} 00:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:18 INFO - Downloading/unpacking jsonschema==2.5.1 00:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:02:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:20 INFO - Downloading functools32-3.2.3-2.tar.gz 00:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:02:20 INFO - warning: no files found matching '*.txt' 00:02:20 INFO - no previously-included directories found matching 'build' 00:02:20 INFO - no previously-included directories found matching 'dist' 00:02:20 INFO - no previously-included directories found matching '.git*' 00:02:20 INFO - Installing collected packages: jsonschema, functools32 00:02:20 INFO - Running setup.py install for functools32 00:02:20 INFO - warning: no files found matching '*.txt' 00:02:20 INFO - no previously-included directories found matching 'build' 00:02:20 INFO - no previously-included directories found matching 'dist' 00:02:20 INFO - no previously-included directories found matching '.git*' 00:02:20 INFO - Successfully installed jsonschema functools32 00:02:20 INFO - Cleaning up... 00:02:20 INFO - Return code: 0 00:02:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:02: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')]} 00:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02: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')]} 00:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:20 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 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:02:20 INFO - Using env: {'DISPLAY': ':0', 00:02:20 INFO - 'HOME': '/home/cltbld', 00:02:20 INFO - 'LANG': 'en_US.UTF-8', 00:02:20 INFO - 'LANGUAGE': 'en_US:en', 00:02:20 INFO - 'LOGNAME': 'cltbld', 00:02:20 INFO - 'MAIL': '/var/mail/cltbld', 00:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:20 INFO - 'MOZ_NO_REMOTE': '1', 00:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:20 INFO - 'NO_EM_RESTART': '1', 00:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:20 INFO - 'PWD': '/builds/slave/test', 00:02:20 INFO - 'SHELL': '/bin/bash', 00:02:20 INFO - 'SHLVL': '1', 00:02:20 INFO - 'TERM': 'linux', 00:02:20 INFO - 'TMOUT': '86400', 00:02:20 INFO - 'USER': 'cltbld', 00:02:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:20 INFO - '_': '/tools/buildbot/bin/python'} 00:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:20 INFO - Downloading/unpacking blobuploader==1.2.4 00:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:22 INFO - Downloading blobuploader-1.2.4.tar.gz 00:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:02:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:02:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:23 INFO - Downloading docopt-0.6.1.tar.gz 00:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:02:23 INFO - Installing collected packages: blobuploader, requests, docopt 00:02:23 INFO - Running setup.py install for blobuploader 00:02:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:02:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:02:23 INFO - Running setup.py install for requests 00:02:24 INFO - Running setup.py install for docopt 00:02:24 INFO - Successfully installed blobuploader requests docopt 00:02:24 INFO - Cleaning up... 00:02:24 INFO - Return code: 0 00:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:02: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')]} 00:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02: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')]} 00:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:24 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 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:02:24 INFO - Using env: {'DISPLAY': ':0', 00:02:24 INFO - 'HOME': '/home/cltbld', 00:02:24 INFO - 'LANG': 'en_US.UTF-8', 00:02:24 INFO - 'LANGUAGE': 'en_US:en', 00:02:24 INFO - 'LOGNAME': 'cltbld', 00:02:24 INFO - 'MAIL': '/var/mail/cltbld', 00:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:24 INFO - 'MOZ_NO_REMOTE': '1', 00:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:24 INFO - 'NO_EM_RESTART': '1', 00:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:24 INFO - 'PWD': '/builds/slave/test', 00:02:24 INFO - 'SHELL': '/bin/bash', 00:02:24 INFO - 'SHLVL': '1', 00:02:24 INFO - 'TERM': 'linux', 00:02:24 INFO - 'TMOUT': '86400', 00:02:24 INFO - 'USER': 'cltbld', 00:02:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:24 INFO - '_': '/tools/buildbot/bin/python'} 00:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:02:24 INFO - Running setup.py (path:/tmp/pip-YFw4LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:02:24 INFO - Running setup.py (path:/tmp/pip-brL473-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:02:24 INFO - Running setup.py (path:/tmp/pip-9qGKbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:02:24 INFO - Running setup.py (path:/tmp/pip-zVIvJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:02:24 INFO - Running setup.py (path:/tmp/pip-SuTUmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:02:24 INFO - Running setup.py (path:/tmp/pip-iqb96H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:02:24 INFO - Running setup.py (path:/tmp/pip-Q8x3Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:02:24 INFO - Running setup.py (path:/tmp/pip-1DNlVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:02:25 INFO - Running setup.py (path:/tmp/pip-uFM9lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:02:25 INFO - Running setup.py (path:/tmp/pip-fslgSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:02:25 INFO - Running setup.py (path:/tmp/pip-gjmx1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:02:25 INFO - Running setup.py (path:/tmp/pip-WV3hhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:02:25 INFO - Running setup.py (path:/tmp/pip-pwzDjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:02:25 INFO - Running setup.py (path:/tmp/pip-P6oMrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:25 INFO - Running setup.py (path:/tmp/pip-umB9mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:02:25 INFO - Running setup.py (path:/tmp/pip-rEgoN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:02:25 INFO - Running setup.py (path:/tmp/pip-fj_0_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:02:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:02:25 INFO - Running setup.py install for manifestparser 00:02:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:02:25 INFO - Running setup.py install for mozcrash 00:02:25 INFO - Running setup.py install for mozdebug 00:02:25 INFO - Running setup.py install for mozdevice 00:02:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Running setup.py install for mozfile 00:02:26 INFO - Running setup.py install for mozhttpd 00:02:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Running setup.py install for mozinfo 00:02:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Running setup.py install for mozInstall 00:02:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Running setup.py install for mozleak 00:02:26 INFO - Running setup.py install for mozlog 00:02:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Running setup.py install for moznetwork 00:02:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:02:26 INFO - Running setup.py install for mozprocess 00:02:26 INFO - Running setup.py install for mozprofile 00:02:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:02:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:02:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:02:27 INFO - Running setup.py install for mozrunner 00:02:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:02:27 INFO - Running setup.py install for mozscreenshot 00:02:27 INFO - Running setup.py install for moztest 00:02:27 INFO - Running setup.py install for mozversion 00:02:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:02:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:02:27 INFO - Cleaning up... 00:02:27 INFO - Return code: 0 00:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:02:27 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')]} 00:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:27 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')]} 00:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:27 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 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:02:27 INFO - Using env: {'DISPLAY': ':0', 00:02:27 INFO - 'HOME': '/home/cltbld', 00:02:27 INFO - 'LANG': 'en_US.UTF-8', 00:02:27 INFO - 'LANGUAGE': 'en_US:en', 00:02:27 INFO - 'LOGNAME': 'cltbld', 00:02:27 INFO - 'MAIL': '/var/mail/cltbld', 00:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:27 INFO - 'MOZ_NO_REMOTE': '1', 00:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:27 INFO - 'NO_EM_RESTART': '1', 00:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:27 INFO - 'PWD': '/builds/slave/test', 00:02:27 INFO - 'SHELL': '/bin/bash', 00:02:27 INFO - 'SHLVL': '1', 00:02:27 INFO - 'TERM': 'linux', 00:02:27 INFO - 'TMOUT': '86400', 00:02:27 INFO - 'USER': 'cltbld', 00:02:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:27 INFO - '_': '/tools/buildbot/bin/python'} 00:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:02:27 INFO - Running setup.py (path:/tmp/pip-qU4mUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:02:27 INFO - Running setup.py (path:/tmp/pip-gBJz8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:02:27 INFO - Running setup.py (path:/tmp/pip-Kin4jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:02:27 INFO - Running setup.py (path:/tmp/pip-ntl7HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:02:28 INFO - Running setup.py (path:/tmp/pip-IUEKGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:02:28 INFO - Running setup.py (path:/tmp/pip-g5pIGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:02:28 INFO - Running setup.py (path:/tmp/pip-nc564z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:02:28 INFO - Running setup.py (path:/tmp/pip-H5YCoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:02:28 INFO - Running setup.py (path:/tmp/pip-ruIsvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:02:28 INFO - Running setup.py (path:/tmp/pip-OrIv9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:02:28 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)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:02:28 INFO - Running setup.py (path:/tmp/pip-_JWVmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:02:28 INFO - Running setup.py (path:/tmp/pip-drmKB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:02:28 INFO - Running setup.py (path:/tmp/pip-3TT06C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:02:28 INFO - Running setup.py (path:/tmp/pip-EsW5nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:28 INFO - Running setup.py (path:/tmp/pip-n5UQsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:02:28 INFO - Running setup.py (path:/tmp/pip-uFfjSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:02:28 INFO - Running setup.py (path:/tmp/pip-T2jCd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:02:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:02:30 INFO - Downloading blessings-1.6.tar.gz 00:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:02:30 INFO - Installing collected packages: blessings 00:02:30 INFO - Running setup.py install for blessings 00:02:31 INFO - Successfully installed blessings 00:02:31 INFO - Cleaning up... 00:02:31 INFO - Return code: 0 00:02:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:02:31 INFO - Reading from file tmpfile_stdout 00:02:31 INFO - Current package versions: 00:02:31 INFO - argparse == 1.2.1 00:02:31 INFO - blessings == 1.6 00:02:31 INFO - blobuploader == 1.2.4 00:02:31 INFO - docopt == 0.6.1 00:02:31 INFO - functools32 == 3.2.3-2 00:02:31 INFO - jsonschema == 2.5.1 00:02:31 INFO - manifestparser == 1.1 00:02:31 INFO - mozInstall == 1.12 00:02:31 INFO - mozcrash == 0.17 00:02:31 INFO - mozdebug == 0.1 00:02:31 INFO - mozdevice == 0.48 00:02:31 INFO - mozfile == 1.2 00:02:31 INFO - mozhttpd == 0.7 00:02:31 INFO - mozinfo == 0.9 00:02:31 INFO - mozleak == 0.1 00:02:31 INFO - mozlog == 3.2 00:02:31 INFO - moznetwork == 0.27 00:02:31 INFO - mozprocess == 0.22 00:02:31 INFO - mozprofile == 0.28 00:02:31 INFO - mozrunner == 6.11 00:02:31 INFO - mozscreenshot == 0.1 00:02:31 INFO - mozsystemmonitor == 0.3 00:02:31 INFO - moztest == 0.7 00:02:31 INFO - mozversion == 1.4 00:02:31 INFO - psutil == 3.1.1 00:02:31 INFO - requests == 1.2.3 00:02:31 INFO - wsgiref == 0.1.2 00:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:31 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 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:02:31 INFO - Using env: {'DISPLAY': ':0', 00:02:31 INFO - 'HOME': '/home/cltbld', 00:02:31 INFO - 'LANG': 'en_US.UTF-8', 00:02:31 INFO - 'LANGUAGE': 'en_US:en', 00:02:31 INFO - 'LOGNAME': 'cltbld', 00:02:31 INFO - 'MAIL': '/var/mail/cltbld', 00:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:31 INFO - 'MOZ_NO_REMOTE': '1', 00:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:31 INFO - 'NO_EM_RESTART': '1', 00:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:31 INFO - 'PWD': '/builds/slave/test', 00:02:31 INFO - 'SHELL': '/bin/bash', 00:02:31 INFO - 'SHLVL': '1', 00:02:31 INFO - 'TERM': 'linux', 00:02:31 INFO - 'TMOUT': '86400', 00:02:31 INFO - 'USER': 'cltbld', 00:02:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:31 INFO - '_': '/tools/buildbot/bin/python'} 00:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:02:31 INFO - Cleaning up... 00:02:31 INFO - Return code: 0 00:02:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xac1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, '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': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:02:31 INFO - Using env: {'DISPLAY': ':0', 00:02:31 INFO - 'HOME': '/home/cltbld', 00:02:31 INFO - 'LANG': 'en_US.UTF-8', 00:02:31 INFO - 'LANGUAGE': 'en_US:en', 00:02:31 INFO - 'LOGNAME': 'cltbld', 00:02:31 INFO - 'MAIL': '/var/mail/cltbld', 00:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:31 INFO - 'MOZ_NO_REMOTE': '1', 00:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:31 INFO - 'NO_EM_RESTART': '1', 00:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:31 INFO - 'PWD': '/builds/slave/test', 00:02:31 INFO - 'SHELL': '/bin/bash', 00:02:31 INFO - 'SHLVL': '1', 00:02:31 INFO - 'TERM': 'linux', 00:02:31 INFO - 'TMOUT': '86400', 00:02:31 INFO - 'USER': 'cltbld', 00:02:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:31 INFO - '_': '/tools/buildbot/bin/python'} 00:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:02:31 INFO - Cleaning up... 00:02:31 INFO - Return code: 0 00:02:31 INFO - Running post-action listener: _resource_record_post_action 00:02:31 INFO - Running post-action listener: _start_resource_monitoring 00:02:31 INFO - Starting resource monitoring. 00:02:31 INFO - ##### 00:02:31 INFO - ##### Finished create-virtualenv step (success) 00:02:31 INFO - ##### 00:02:31 INFO - ##### 00:02:31 INFO - ##### Running install step. 00:02:31 INFO - ##### 00:02:31 INFO - Running pre-action listener: _resource_record_pre_action 00:02:31 INFO - Running main action method: install 00:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:02:32 INFO - Reading from file tmpfile_stdout 00:02:32 INFO - Detecting whether we're running mozinstall >=1.0... 00:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:02:32 INFO - Reading from file tmpfile_stdout 00:02:32 INFO - Output received: 00:02:32 INFO - Usage: mozinstall [options] installer 00:02:32 INFO - Options: 00:02:32 INFO - -h, --help show this help message and exit 00:02:32 INFO - -d DEST, --destination=DEST 00:02:32 INFO - Directory to install application into. [default: 00:02:32 INFO - "/builds/slave/test"] 00:02:32 INFO - --app=APP Application being installed. [default: firefox] 00:02:32 INFO - mkdir: /builds/slave/test/build/application 00:02:32 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'] 00:02:32 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 00:02:48 INFO - Reading from file tmpfile_stdout 00:02:48 INFO - Output received: 00:02:48 INFO - /builds/slave/test/build/application/firefox/firefox 00:02:48 INFO - Running post-action listener: _resource_record_post_action 00:02:48 INFO - ##### 00:02:48 INFO - ##### Finished install step (success) 00:02:48 INFO - ##### 00:02:48 INFO - ##### 00:02:48 INFO - ##### Running run-tests step. 00:02:48 INFO - ##### 00:02:48 INFO - Running pre-action listener: _resource_record_pre_action 00:02:48 INFO - Running main action method: run_tests 00:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:02:48 INFO - Python 2.7.3 00:02:48 INFO - Return code: 0 00:02:48 INFO - grabbing minidump binary from tooltool 00:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:02:48 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 0xd7f570>, '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 0xd80470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:02:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:02:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:02:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:02:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:02:48 INFO - Return code: 0 00:02:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:02:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:02:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:02:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:02:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:02:48 INFO - Using env: {'DISPLAY': ':0', 00:02:48 INFO - 'HOME': '/home/cltbld', 00:02:48 INFO - 'LANG': 'en_US.UTF-8', 00:02:48 INFO - 'LANGUAGE': 'en_US:en', 00:02:48 INFO - 'LOGNAME': 'cltbld', 00:02:48 INFO - 'MAIL': '/var/mail/cltbld', 00:02:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:02:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:48 INFO - 'MOZ_NO_REMOTE': '1', 00:02:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:48 INFO - 'NO_EM_RESTART': '1', 00:02:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:48 INFO - 'PWD': '/builds/slave/test', 00:02:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:02:48 INFO - 'SHELL': '/bin/bash', 00:02:48 INFO - 'SHLVL': '1', 00:02:48 INFO - 'TERM': 'linux', 00:02:48 INFO - 'TMOUT': '86400', 00:02:48 INFO - 'USER': 'cltbld', 00:02:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734', 00:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:48 INFO - '_': '/tools/buildbot/bin/python'} 00:02:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:02:48 INFO - mozversion application_buildid: 20160628230027 00:02:48 INFO - mozversion application_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 00:02:48 INFO - mozversion application_display_name: Nightly 00:02:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:02:48 INFO - mozversion application_name: Firefox 00:02:48 INFO - mozversion application_remotingname: firefox 00:02:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:02:48 INFO - mozversion application_vendor: Mozilla 00:02:48 INFO - mozversion application_version: 50.0a1 00:02:48 INFO - mozversion platform_buildid: 20160628230027 00:02:48 INFO - mozversion platform_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 00:02:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:02:48 INFO - mozversion platform_version: 50.0a1 00:02:48 INFO - using testdate: 1467183768 00:02:48 INFO - actual date: 1467183768 00:02:48 INFO - starting webserver on 'localhost:51489' 00:02:48 INFO - SUITE-START | Running 2 tests 00:02:48 INFO - TEST-START | dromaeo_css 00:02:48 INFO - operating with platform_type : linux_ 00:02:48 INFO - Initialising browser for dromaeo_css test... 00:02:48 INFO - TEST-INFO | started process 4766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7H7Ehh/profile http://localhost:51489/getInfo.html) 00:02:53 INFO - PROCESS | 4766 | __metrics Screen width/height:1600/1200 00:02:53 INFO - PROCESS | 4766 | colorDepth:24 00:02:53 INFO - PROCESS | 4766 | Browser inner width/height: 1024/697 00:02:53 INFO - PROCESS | 4766 | __metrics 00:02:53 ERROR - PROCESS | 4766 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 00:02:54 INFO - TEST-INFO | 4766: exit 0 00:02:54 INFO - Browser initialized. 00:02:54 INFO - Running cycle 1/1 for dromaeo_css test... 00:02:54 INFO - TEST-INFO | started process 4886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7H7Ehh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:03:06 INFO - PROCESS | 4886 | RSS: Main: 169226240 00:03:06 INFO - PROCESS | 4886 | 00:03:56 INFO - PROCESS | 4886 | 1467183836450 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] 00:06:08 INFO - PROCESS | 4886 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51489/tests/dromaeo/cssquery-ext.html) 00:06:09 INFO - PROCESS | 4886 | RSS: Main: 169177088 00:06:09 INFO - PROCESS | 4886 | 00:09:11 INFO - PROCESS | 4886 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-ext.html (next: http://localhost:51489/tests/dromaeo/cssquery-jquery.html) 00:09:12 INFO - PROCESS | 4886 | RSS: Main: 170291200 00:09:12 INFO - PROCESS | 4886 | 00:12:14 INFO - PROCESS | 4886 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51489/tests/dromaeo/cssquery-mootools.html) 00:12:14 INFO - PROCESS | 4886 | RSS: Main: 169361408 00:12:14 INFO - PROCESS | 4886 | 00:15:16 INFO - PROCESS | 4886 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51489/tests/dromaeo/cssquery-prototype.html) 00:15:17 INFO - PROCESS | 4886 | RSS: Main: 171466752 00:15:17 INFO - PROCESS | 4886 | 00:18:20 INFO - PROCESS | 4886 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51489/tests/dromaeo/cssquery-yui.html) 00:18:20 INFO - PROCESS | 4886 | RSS: Main: 170250240 00:18:20 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | Cycle 1(1): loaded http://localhost:51489/tests/dromaeo/cssquery-yui.html (next: http://localhost:51489/tests/dromaeo/cssquery-dojo.html) 00:21:23 INFO - PROCESS | 4886 | RSS: Main: 174563328 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | __start_tp_report 00:21:23 INFO - PROCESS | 4886 | _x_x_mozilla_page_load 00:21:23 INFO - PROCESS | 4886 | _x_x_mozilla_page_load_details 00:21:23 INFO - PROCESS | 4886 | |i|pagename|runs| 00:21:23 INFO - PROCESS | 4886 | |0;dojo.html;2580.896764129435;2629.3426643339158;2676.611891275765;2678.1028355500907;2678.638383818185;4718.5281471852795;4759.643026772993;4777.8088876444945;4838.612910967123;4851.22380419133;4704.623630109591;4793.544613261734;4799.232122860343;4854.101991131643;4858.052679727454;4361.411209486726;4444.622207112399;4513.165064463068;4522.547745225467;4538.750368729735;551.9623807277321;4315.158544083905;4397.362382454542;4412.051408947092;4478.820847166109;4414.668899832525;4432.224360736875;4451.821927122944;4456.420665313521;4493.7977790999485;4428.800703968329;4450.087732014929;4455.376247325377;4459.687821852472;4474.328850672393;4321.956780432187;4384.978075109636;4386.385905973167;4411.139827733593;4434.246178149722;4735.810567577293;4749.121412538691;4813.446453657839;4818.903621927542;4883;5159.458256883011;5178.430372659004;5213.556847667953;5231.084560201949;5258.211268309746;5164.302819119408;5200.141976573861;5201.141811601081;5218.921716174261;5221.765020574046;4821.325014497973;4859.441164266119;4874.09829181599;4883.4628190898975;4910.165271903785;5138.743062846917;5352.277442545284;5379.1393377059485;5401.189821526724;5401.405845357008;5124.8206312778875;5168.405633352213;5178.197379406198;5189.325387699575;5238.188080847474;5235.240890070919;5243.213517972335;5244.606654500928;5246;5309.495597918191;4941.283513890466;5035.521625445577;5118;5154;5164.225366195101;5121.103806833789;5141.897162056813;5147.944671342366;5150.768215430315;5166.405863325691;4442.2892337225885;4474.373587697725;4476.194285028661;4477.90078551832;4511.481179664315;3774.75464094833;3805.543334799842;3822.445745366906;3921.941170882439;3932.0956180078742;4383.561643835655;4445.066536027406;4446.444194475691;4470.038941627566;4496.887577810516;5232.790688372498;5233.973830130825;5243.187305967581;5248.868778280574;5291.603129765206;4395.934060989088;4480.036792089716;4484.618807401343;4500.919779252956;4552.317152427162;4711.646626503026;4713.34013238147;4716.905661886812;4727.101850648366;4764.523547645277;4818.349522814446;4883.3651625288485;4888.92666609994;4898.53463920927;4938.08645400602;5047.41954675217;5187.714675692873;5219.425863155126;5238.68567885928;5261;4848.903021939612;4880.145974454385;4887.951120488749;4905.313256144072;4944.48082951285;5177.2492988515705;5178.404483484447;5183.300254465599;5185.22221666753;5191.428942816212;5179.792808287626;5196.376434827845;5214.2960700304975;5255.842324730264;5266.473352664703;5055.545000949932;5111.309973153577;5119.590432765444;5120.974395128001;5162.6386152968935;4893.584045356185;4988.102141614544;5044.974775126101;5053.898922021613;5082.2122571001555;4954.405471343462;4965.577925876341;4971.751412429292;4980.601551875914;5051.191809310492;5043.142665746906;5051.166557517969;5060.797568097235;5107.974460127675;5110.284560161655;4952.8761780955765;4983.800647974041;4986.390310900238;4991.850244492671;5040.14317566022 00:21:23 INFO - PROCESS | 4886 | |1;ext.html;539.511266264678;590.4626789621445;594.274984518887;602.8402473344568;604.3171216525327;33828.49257261143;37599.872003839926;37619.247615047716;37653.43519847204;37753.622463775355;38195.61804381955;39061.414078788766;39130.608693913055;39279.21441571167;39302.21395572094;7688.154303026663;7771.961140194319;7784.26049525297;7833.334166595846;7844.450888437812;7743.574103424309;7754.302112809846;7775.844483110334;7779.805504862367;7814.609269536529;7823.295903368696;7823.608819559027;7833.177516360785;7894.802629934269;7925.2867241948215;7747.806304842367;7794.298513133816;7818.45270831042;7850.057993040871;7873.921260787405;7754.612269386508;7821.921780782176;7829.686812527492;7839.294463498312;7849.45053846231;36319.63680363215;36720;36739.816300918326;36760.63239367626;36778.264434711426;3097.566340712302;3233.951490727641;3279.7868138570916;3378.0879162626197;3544.220271540257;29526.704732952825;29879;30014.399712005637;30029;30243.546346804815;3511.7190624750215;3598.4242521196484;3603.0632035670915;3606.963930360689;3673.651003154696;255039;255642;256764;256981.99999999814;257531;31509.369812603618;51314.74342628338;51345;51746.74126629343;51768.22347664788;32356.22040787732;33749.49375759366;33934.32131357359;34046.82976585151;34096;11544.711382215512;11605.419729013516;11616.825747613793;11638.301701897914;11643.941780291045;10174.186065114773;10249.33379330341;10252.179825613934;10261.230407719451;10263.846042309371;7793.220677932275;7842.176571460029;7872.370210383156;7986.680532778624;7987.680492780224;3181.427343078222;3181.602299712536;3200.3279311344413;3205.1346136543;3209.1335339458683;863.9222469977732;918.8162367526521;959.3572306554626;959.5154447004358;963.6145541783343;27652.096529864477;28374;28675;28849.423011539653;29039.854800726283;886.4061079077034;956.9521523923776;978.4031740638205;1005.5625802775816;1046.576136664652;14528.491502797351;14797.260136993107;14847.70304593902;14959.102453852804;15160.545183644508;367961;373655;373916;373958;375056;49936.250956235686;50022;50271.49728502741;50281;50332.74833625808;1149.1668540308376;1156.4738044189874;1173.6537721372044;1175.3476820364779;1188.3226560860398;26254.606180907685;27815.16554503368;27818.30454238579;28140.296492587848;28145.43709125847;41745.16509669729;41949.370759438025;42089.78955105205;42196.789016054725;42260.78869605633;316970;318049;320988;322742;323145;22467.10131594783;23056.884715576987;25139.87430062911;25743.485130297664;25856;41766.791166045194;42041.78979105207;42733;42754.78622606867;43309.13381732284;35900.28199436049;36694.44958325574;36793.816030919676;36809;37011.6298837019;35625.82187089048;36147.819260903525;36187;36261.45607815832;36389.454158187116;30848;34842.12894677653;35894.641053590174;35966.820165899;36954.26091478209;32134.517982230755;33185.83407082949;33564.496532551544;33745;33825;21510.677339839604;22107.22624708192;22251.888740556195;25247;25891.61162582525 00:21:23 INFO - PROCESS | 4886 | |2;jquery.html;345.93946059439594;353.10487913140184;355.81675437149863;358.9389803733365;364.75379119094623;15946.760798588031;16785.24466399012;16926.74609880853;17243.396481123164;17263.48209553712;16039.759403608956;16387.754183687255;16951.32194712213;17030.914845425785;17037.403690870822;5002.799888004475;5159.845204643867;5201.167813149897;5203.19350500673;5205.245239440298;3678.521792167028;5110.846674599749;5813.215215945836;6139.7851075212375;6156.476699480527;6153.35389784073;6156.876862462748;6178.783742569011;6200.224971878515;6207.379262073801;5019.573336266421;5352.598555108363;5354.892902141954;5394.406615272317;5397.892042159174;5243.895122097575;5250.264962905197;5419.810306639288;5421.9457805421835;5422.105352616813;19739.40781776549;19835.305764298326;19928.90035549813;20150.798492015037;20357.592848143104;1932.4492519631838;1959.9216031358872;1960.2257108442086;2137.2840098567;2323.6863023491783;9042.276617870555;9047.276217902552;9127.634894604207;9265.490398028105;9452.95273523628;1701.0219124003747;1713.4516954574542;1718.0550697116537;1779.4394765648779;1815.3646223821688;65430.67284663594;67684.6615766918;67865.66067169633;68413.65793171052;69453.3054669452;9608.2793790466;9821.165200958;9956.333623110164;10026.09765121128;10150;13610.727785444236;13662.52181173674;13763.174209547258;13769.449222031208;13797.310134493235;6963.4777391695825;7000.159980802337;7012.614306213105;7194.568325900463;7208.56748595086;6617.43751781104;6652.567583107082;6705.798826035227;6778.051072849805;6869.519133660696;4238.385434112037;4243.384709217146;4268.381084742695;4314.6548276138465;4361.2367835629275;1659.6182877938143;1671.5094509181233;1782.5989152440857;1798.9640207195782;1811.673898698247;372.4115896882918;400.9959900400959;415.775481240133;839.8194388206565;865.883010915924;10355.741106472247;10374.17006639467;10417.479126043667;10567.313124646873;10612.681619551426;399.6830443687997;813.4265342933218;833.9791505212297;893.7586851550045;910.8770316007254;9101.40840845343;9134.778699170667;9218.53907304632;9265.629374824932;9319.720408387759;382781;392483;417733;435368;435691;49365;70706.9393959091;81072.59463702762;82169.58915205386;83857.58071209605;924.5284904698518;929.7815013471828;954.4845783276953;958.1616085924816;969.4231932000448;14474.256272893952;14474.27628618586;14674.192919389536;14717.705645887236;14816.333265003317;34463.72594603508;35319.646803531636;35370;36938.630613693516;38018.80990595029;53138;54220;54356.728216358664;54409.183862241305;54513.72743136259;6446.806595802133;6738.7304507819135;6866.279040700654;6902.654867256517;6935.237123916264;10613.575456981634;11785.116116291483;11968.700782480508;12050.879491204976;12342.50629974827;9132.360734748503;9252.907470925205;9358.204552613104;9573.090556397132;9650.276229282692;10134.695959121238;10188.337758045704;10372.74068148272;10423.68728938133;10436.739081523023;9352.251819854531;9577.042295770645;9765.511724413893;9852.507374631097;9945.403275803475;6913.792586222421;6915.101036865175;6929.792106236821;7022.613756243456;7080.964595176991;7335.559866408033;8437.915620843713;9207.86188207164;9292.58183381763;9720.902790972283 00:21:23 INFO - PROCESS | 4886 | |3;mootools.html;1370.4518192722912;1389.7845833895744;1468.581454285529;1633.7631043498686;1664.1097013097994;6497.90253146202;7246.673899674514;7324.48728588999;7746.0317460317465;7752.844943101135;7452.180260171391;7595.164531901486;7667.42494312926;7676.117246516652;7689.807754806133;2163.1996161420257;2196.077647388101;2197.154095673169;2199.49411635324;2202.9559408811815;2144.1744928202597;2175.1516908405656;2178.106976139783;2180;2183.7488688800754;2165.9350219493363;2196.187410658059;2206.977930220701;2207.5915955548276;2208.1277895231374;2100.306898723425;2120.204923153817;2125.628015097367;2125.6492678707996;2145.753238377591;2008.9095990680455;2015.2745011795741;2084.6143463459307;2104.5054412213117;2106.9051892664716;7669.079710434784;7679.308862202429;7689.538627682357;7714.459987800856;7731.188225236326;4313.698041137121;4460.643148548108;4462.598366147063;4462.620677242438;4463.866084017484;2834.6598408190944;2934.457125431802;2994.386150839073;3020.7734419918593;3032.8938487152845;929.8140371925574;952.8618350339232;972.9951350243203;973.6397532912868;986.8322385194534;10188.694339169837;10211.79576408475;10222.131118854906;10245.89754102457;10279.743006424824;3984.183242435352;4009.69927255457;4097.037196258877;4124.979375103166;4125.525564560054;8847.292216622654;8859.24696400813;8864.20222180007;8875.068117847663;8879.42283751567;4411.536788637211;4428.800703968329;4434.556544345604;4447.132809102259;4448.377227188196;3464.428369319034;3879.2047630235734;4042.3734321180264;4089.5092588889524;4092.3656833190903;3438.6045604755773;3580.427131658922;3618.782873027627;3637.0543658648944;3662.377395842713;1110.655696734015;1129.0854407929603;1140.8402823604536;1153;1153.5385845661635;817.9509229446252;824.5959479854828;836.9788857593726;853.7396094191331;854.1927878155084;4859.2954021667365;4988.176950803077;5118;5130.769115389817;5264.078786212397;868.405142477405;889.573004957624;907.3648446087765;926.2127191886842;930.497531333086;3331;3444.2594842108565;3465.428204346305;3501.9124521887156;3511.0695665648623;9146.90853091474;9313.487758173365;9378.85931711025;9380.061993800566;9434.528273586293;9308.162265396148;9333.673321433716;9348.205402540723;9380.296477764196;9434.764130896645;6788.93211067883;6884.931150688429;6941.618210998343;6951.756688515878;7059.647017649097;5039.672421292605;5165.380154381348;5172.482751724798;5207.739613019258;5341.038613049533;8400.579971001303;8468.280196183394;8522.573871306286;8528.317734581342;8528.786780330542;8270.83458330818;8629.913700863162;8637.69768058115;8738.475691458532;8808.51553164582;5878.764849405976;6377.947638639758;6635.535512514078;6735.393814556517;6884.173899132136;7462.813429664085;7492;7505.136909255505;7524.962375188089;7545.094588649177;6536.7712130075215;6840.589564626139;6841.076454678555;6886.51794374389;6916.273791251846;6606.8017959461295;6610.10763546915;6660.666966651745;6716.059751634873;6766.695498702472;6064.3935606439;6144.662043587646;6145.877082458415;6210.099535567408;6217.036359364306;4394.538573449741;4414.381986521954;4442.73343599385;4460.420145381079;4463.509014008521;4425.203463376494;4454.532274111171;4463.085067561207;4474.664400170065;4519.028408892104 00:21:23 INFO - PROCESS | 4886 | |4;prototype.html;299.18770537989354;299.7467140266474;301.3490859742955;303.375047402351;303.79493841656875;5141.8457446276625;5147;5163.767630456629;5177.896442071156;5184.326037615109;5106.1574840151425;5109.795608175668;5110.463401342852;5134.382669459118;5149.098907691157;3831.9042023949414;3852.4012534798167;3961.2671655743634;3981.5222173339093;3981.6217459341315;3964.781936993464;3972.695836414887;3975.5030621172355;3980.3631418972827;3987.421823835542;3956.3076461619244;3957.267905437489;3959.6832253419802;3959.762414255154;3963.425303331015;3689.2252626948375;3908.1597456546697;3922.372420412749;3963.702722295825;3966.9008274793073;3366.276250606107;3378.847951842173;3382.0868365541164;3382.0868365541414;3390.9830450847835;4982.551570358685;4983.72589507577;4990.65065445419;4997.2004479283505;5000.174971129759;4237.470316210473;4465.977670111661;4469.3296005599095;4472.1502914446155;4476.664250181249;5332.3601167859715;5347.850212204395;5352.84913743547;5360.115580929142;5361.142217245261;3703.925921481582;3726.366517691999;3745.925081498382;3746.7939263340504;3752.4934133891848;5357.303550538405;5578.163275508666;5578.972105139448;5587.273654424939;5608.971955140239;3808.638179372955;3831.1571454280015;3831.5593706723525;3832.463455116286;3841.3085644583684;3858.151206734514;3860.343741563941;3885.533735951704;3896.1818018215927;3902.1610353774076;4433.359656926893;4447.399601053881;4477.462704475483;4483.30508771141;4491.483479399845;5216.66091704038;5356.571474282048;5367.570594352521;5373.194020896819;5413.025655382069;1318.967025824343;1325.6544607223675;1331.1946272504995;1331.7203387288585;1339.4642143142626;821.3018933906131;834.0533494483805;854.4189950833493;863.8704194370895;866.8743032260287;4710.764461776897;4713.336964614981;4718.669693121448;4733.715977041388;4745.217039188496;5451.37309209446;5479.397266300703;5496.4503549645515;5506.669599824023;5526.696031718214;4517.043752620927;4672.462666793363;4677.22825733757;4685.390899183084;4690.296455531698;2894.7105289470883;2895.1604034829666;2911.344947386863;2932.3548819259727;2946.6758656547763;5042;5105.9489405106215;5115.360579927509;5121.308623335802;5133.820316288987;5325.174597937326;5551.583631227674;5583.162525621189;5732.484076433141;5747.5689323300085;5152.819651312186;5177.585793136615;5178;5190.896182076337;5193.480651934852;5565.9721701392855;5593.748281327269;5595.804146854841;5610.410906854721;5621.74702138413;5241.828693640293;5470.863228419322;5475.178723191394;5507.779688812403;5509.311336082989;5164.690118592896;5174.896502069862;5180.352455943007;5187.4553171916405;5207.895842083213;3809.2573347189978;3841.0973421246545;3860.8069596520622;3863.922721545497;3874.690024797953;5411;5610.354809196831;5613.775448982158;5621.442243779153;5623.409541998195;5364.042124624562;5390.676559406448;5417.458254174551;5445.230300152387;5482.671039737628;5243.501867322599;5399.271098401822;5401.6218864679095;5438.700871452108;5459.645123066988;5311.415744268204;5312.867178320573;5322.733863306897;5340.344493207118;5368.892622147457;5147.948520514897;5250.684958902478;5394.838154855361;5448.400675925565;5451.291332126798;5300.416954135119;5321.175217841241;5336.74586472171;5337.226102215234;5340.786368545215 00:21:23 INFO - PROCESS | 4886 | |5;yui.html;694.4999600287792;694.8506071194694;696.1402667705383;725.3979197266269;768.281656651031;12905.741885162302;13435.328233588318;13614.523491677794;13650.522231721892;13681.589552313446;13255.40350684219;13381.130226535293;13414.195148291084;13419;13468.25924574148;628.0641843652948;773.6441237030973;788.668759121169;792.8176519400541;793.8372633610096;791.7426836278232;793.5040599625235;796.1719811396141;797.8364435290752;799.6801279488222;848.4739461533858;848.9278411335044;857.9313654907593;859.5229647545609;861.0915484164204;846.9788255293605;847.1443841719877;847.8643417053273;848.9193526614962;850.7873031742065;615.8983767678328;620.0915658560231;621.6767281013847;622.1662971618053;624.4692011789988;13380.665483362995;13381.598552043455;13407.195568265837;13448.394822233024;13474.865251347459;13374.197548147142;13550.254735989516;13627.931860340734;13881.097728647606;14116.223607701573;10133.391996480235;10192.59229630814;10337.483125843677;10346.379217246915;10354.430506322149;3387.491876218562;3397.8301084945656;3410.9488357674654;3434.244466217428;3514.68367846895;61580.69209653968;61962.38037619611;63353.36646633521;64253;64330.35669643291;10627.84058239127;10682.946585267024;10686.679399618024;10798.838017429745;10868.510917008754;20121.0884965928;20126.798732012492;20129.295474658316;20170.29403970854;20209.696854547194;6825.522213445011;6928.44572434204;6973.267806880306;7082.822929426702;7124.073870396815;3865.1496670732395;3957.3272543667645;3967.3652215645357;4084.36692312692;4088.632023117934;3032.2267821705764;3138.262508310591;3144.9685503145133;3154.022253101546;3164.7784655073924;509.2564855311287;513.383939272874;521.6061873285645;522.3914140026826;527.0276340152412;503.7405736045939;562.3673367461606;562.8958642651122;593.795140676466;594.3580932592789;8031;8049.235322644339;8346.874796878052;8543;8603.612837422332;505.5147058823497;534.6257619666171;567;577.6072270855858;601.3745704467304;3837.520309961255;3956.6043395660204;4000.179963107556;4045.8988525287104;4084.6323830855367;74790.62604686942;77559;78611.21388786154;87796.12203878007;98805;49413.25880111801;52266.73866630719;85968;86750.56624716836;86945;80575.59712201402;82206.58896705598;83132;83455.58272208722;84552;8624.870626940476;8690.869636955324;8722.25860801839;8894.59974301171;9007.594658240263;45672.31491527563;46469.07061858811;47967.760161198974;47971.76014119907;48407.51592484171;68463;70762.64618676873;71496.28503714896;71923;72160.63919680368;10962.177836662442;10978.341299522055;10984.670459886216;11095.667129986114;11411;11780.469878855643;12038.187634432526;12110.414077745118;12224.327661978676;12238.571649992207;11770;12018.579349722717;12089.15375923677;12139.453724582592;12441.937790311353;12036.75926481483;12066.577669781516;12178.08664350195;12183.147179697691;12504.749905001667;11384.886151138382;11711.414429278673;11890.881091188978;12147.149699521302;12524.311162886128;9150.22223111043;9274.304427167854;9354.362986477476;9505.857412138685;9654.03459654029;10009.69970900874;10019.298649094493;10199.592016319264;10202;10341.586336546454 00:21:23 INFO - PROCESS | 4886 | __end_tp_report 00:21:23 INFO - PROCESS | 4886 | __start_cc_report 00:21:23 INFO - PROCESS | 4886 | _x_x_mozilla_cycle_collect,380 00:21:23 INFO - PROCESS | 4886 | __end_cc_report 00:21:23 INFO - PROCESS | 4886 | __startTimestamp1467184883571__endTimestamp 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | ------- Summary: start ------- 00:21:23 INFO - PROCESS | 4886 | Number of tests: 6 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | [#0] dojo.html Cycles:165 Average:4772.84 Median:4910.17 stddev:612.78 (12.5%) stddev-sans-first:590.04 00:21:23 INFO - PROCESS | 4886 | Values: 2580.9 2629.3 2676.6 2678.1 2678.6 4718.5 4759.6 4777.8 4838.6 4851.2 4704.6 4793.5 4799.2 4854.1 4858.1 4361.4 4444.6 4513.2 4522.5 4538.8 552.0 4315.2 4397.4 4412.1 4478.8 4414.7 4432.2 4451.8 4456.4 4493.8 4428.8 4450.1 4455.4 4459.7 4474.3 4322.0 4385.0 4386.4 4411.1 4434.2 4735.8 4749.1 4813.4 4818.9 4883.0 5159.5 5178.4 5213.6 5231.1 5258.2 5164.3 5200.1 5201.1 5218.9 5221.8 4821.3 4859.4 4874.1 4883.5 4910.2 5138.7 5352.3 5379.1 5401.2 5401.4 5124.8 5168.4 5178.2 5189.3 5238.2 5235.2 5243.2 5244.6 5246.0 5309.5 4941.3 5035.5 5118.0 5154.0 5164.2 5121.1 5141.9 5147.9 5150.8 5166.4 4442.3 4474.4 4476.2 4477.9 4511.5 3774.8 3805.5 3822.4 3921.9 3932.1 4383.6 4445.1 4446.4 4470.0 4496.9 5232.8 5234.0 5243.2 5248.9 5291.6 4395.9 4480.0 4484.6 4500.9 4552.3 4711.6 4713.3 4716.9 4727.1 4764.5 4818.3 4883.4 4888.9 4898.5 4938.1 5047.4 5187.7 5219.4 5238.7 5261.0 4848.9 4880.1 4888.0 4905.3 4944.5 5177.2 5178.4 5183.3 5185.2 5191.4 5179.8 5196.4 5214.3 5255.8 5266.5 5055.5 5111.3 5119.6 5121.0 5162.6 4893.6 4988.1 5045.0 5053.9 5082.2 4954.4 4965.6 4971.8 4980.6 5051.2 5043.1 5051.2 5060.8 5108.0 5110.3 4952.9 4983.8 4986.4 4991.9 5040.1 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | [#1] ext.html Cycles:180 Average:45846.23 Median:36224.23 stddev:84402.78 (233.0%) stddev-sans-first:84571.00 00:21:23 INFO - PROCESS | 4886 | Values: 539.5 590.5 594.3 602.8 604.3 33828.5 37599.9 37619.2 37653.4 37753.6 38195.6 39061.4 39130.6 39279.2 39302.2 7688.2 7772.0 7784.3 7833.3 7844.5 7743.6 7754.3 7775.8 7779.8 7814.6 7823.3 7823.6 7833.2 7894.8 7925.3 7747.8 7794.3 7818.5 7850.1 7873.9 7754.6 7821.9 7829.7 7839.3 7849.5 36319.6 36720.0 36739.8 36760.6 36778.3 3097.6 3234.0 3279.8 3378.1 3544.2 29526.7 29879.0 30014.4 30029.0 30243.5 3511.7 3598.4 3603.1 3607.0 3673.7 255039.0 255642.0 256764.0 256982.0 257531.0 31509.4 51314.7 51345.0 51746.7 51768.2 32356.2 33749.5 33934.3 34046.8 34096.0 11544.7 11605.4 11616.8 11638.3 11643.9 10174.2 10249.3 10252.2 10261.2 10263.8 7793.2 7842.2 7872.4 7986.7 7987.7 3181.4 3181.6 3200.3 3205.1 3209.1 863.9 918.8 959.4 959.5 963.6 27652.1 28374.0 28675.0 28849.4 29039.9 886.4 957.0 978.4 1005.6 1046.6 14528.5 14797.3 14847.7 14959.1 15160.5 367961.0 373655.0 373916.0 373958.0 375056.0 49936.3 50022.0 50271.5 50281.0 50332.7 1149.2 1156.5 1173.7 1175.3 1188.3 26254.6 27815.2 27818.3 28140.3 28145.4 41745.2 41949.4 42089.8 42196.8 42260.8 316970.0 318049.0 320988.0 322742.0 323145.0 22467.1 23056.9 25139.9 25743.5 25856.0 41766.8 42041.8 42733.0 42754.8 43309.1 35900.3 36694.4 36793.8 36809.0 37011.6 35625.8 36147.8 36187.0 36261.5 36389.5 30848.0 34842.1 35894.6 35966.8 36954.3 32134.5 33185.8 33564.5 33745.0 33825.0 21510.7 22107.2 22251.9 25247.0 25891.6 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | [#2] jquery.html Cycles:180 Average:24504.99 Median:5247.08 stddev:68150.17 (1298.8%) stddev-sans-first:68317.21 00:21:23 INFO - PROCESS | 4886 | Values: 345.9 353.1 355.8 358.9 364.8 15946.8 16785.2 16926.7 17243.4 17263.5 16039.8 16387.8 16951.3 17030.9 17037.4 5002.8 5159.8 5201.2 5203.2 5205.2 3678.5 5110.8 5813.2 6139.8 6156.5 6153.4 6156.9 6178.8 6200.2 6207.4 5019.6 5352.6 5354.9 5394.4 5397.9 5243.9 5250.3 5419.8 5421.9 5422.1 19739.4 19835.3 19928.9 20150.8 20357.6 1932.4 1959.9 1960.2 2137.3 2323.7 9042.3 9047.3 9127.6 9265.5 9453.0 1701.0 1713.5 1718.1 1779.4 1815.4 65430.7 67684.7 67865.7 68413.7 69453.3 9608.3 9821.2 9956.3 10026.1 10150.0 13610.7 13662.5 13763.2 13769.4 13797.3 6963.5 7000.2 7012.6 7194.6 7208.6 6617.4 6652.6 6705.8 6778.1 6869.5 4238.4 4243.4 4268.4 4314.7 4361.2 1659.6 1671.5 1782.6 1799.0 1811.7 372.4 401.0 415.8 839.8 865.9 10355.7 10374.2 10417.5 10567.3 10612.7 399.7 813.4 834.0 893.8 910.9 9101.4 9134.8 9218.5 9265.6 9319.7 382781.0 392483.0 417733.0 435368.0 435691.0 49365.0 70706.9 81072.6 82169.6 83857.6 924.5 929.8 954.5 958.2 969.4 14474.3 14474.3 14674.2 14717.7 14816.3 34463.7 35319.6 35370.0 36938.6 38018.8 53138.0 54220.0 54356.7 54409.2 54513.7 6446.8 6738.7 6866.3 6902.7 6935.2 10613.6 11785.1 11968.7 12050.9 12342.5 9132.4 9252.9 9358.2 9573.1 9650.3 10134.7 10188.3 10372.7 10423.7 10436.7 9352.3 9577.0 9765.5 9852.5 9945.4 6913.8 6915.1 6929.8 7022.6 7081.0 7335.6 8437.9 9207.9 9292.6 9720.9 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | [#3] mootools.html Cycles:180 Average:5005.35 Median:5168.93 stddev:2771.65 (53.6%) stddev-sans-first:2765.96 00:21:23 INFO - PROCESS | 4886 | Values: 1370.5 1389.8 1468.6 1633.8 1664.1 6497.9 7246.7 7324.5 7746.0 7752.8 7452.2 7595.2 7667.4 7676.1 7689.8 2163.2 2196.1 2197.2 2199.5 2203.0 2144.2 2175.2 2178.1 2180.0 2183.7 2165.9 2196.2 2207.0 2207.6 2208.1 2100.3 2120.2 2125.6 2125.6 2145.8 2008.9 2015.3 2084.6 2104.5 2106.9 7669.1 7679.3 7689.5 7714.5 7731.2 4313.7 4460.6 4462.6 4462.6 4463.9 2834.7 2934.5 2994.4 3020.8 3032.9 929.8 952.9 973.0 973.6 986.8 10188.7 10211.8 10222.1 10245.9 10279.7 3984.2 4009.7 4097.0 4125.0 4125.5 8847.3 8859.2 8864.2 8875.1 8879.4 4411.5 4428.8 4434.6 4447.1 4448.4 3464.4 3879.2 4042.4 4089.5 4092.4 3438.6 3580.4 3618.8 3637.1 3662.4 1110.7 1129.1 1140.8 1153.0 1153.5 818.0 824.6 837.0 853.7 854.2 4859.3 4988.2 5118.0 5130.8 5264.1 868.4 889.6 907.4 926.2 930.5 3331.0 3444.3 3465.4 3501.9 3511.1 9146.9 9313.5 9378.9 9380.1 9434.5 9308.2 9333.7 9348.2 9380.3 9434.8 6788.9 6884.9 6941.6 6951.8 7059.6 5039.7 5165.4 5172.5 5207.7 5341.0 8400.6 8468.3 8522.6 8528.3 8528.8 8270.8 8629.9 8637.7 8738.5 8808.5 5878.8 6377.9 6635.5 6735.4 6884.2 7462.8 7492.0 7505.1 7525.0 7545.1 6536.8 6840.6 6841.1 6886.5 6916.3 6606.8 6610.1 6660.7 6716.1 6766.7 6064.4 6144.7 6145.9 6210.1 6217.0 4394.5 4414.4 4442.7 4460.4 4463.5 4425.2 4454.5 4463.1 4474.7 4519.0 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | [#4] prototype.html Cycles:180 Average:4432.24 Median:5118.33 stddev:1315.28 (25.7%) stddev-sans-first:1281.86 00:21:23 INFO - PROCESS | 4886 | Values: 299.2 299.7 301.3 303.4 303.8 5141.8 5147.0 5163.8 5177.9 5184.3 5106.2 5109.8 5110.5 5134.4 5149.1 3831.9 3852.4 3961.3 3981.5 3981.6 3964.8 3972.7 3975.5 3980.4 3987.4 3956.3 3957.3 3959.7 3959.8 3963.4 3689.2 3908.2 3922.4 3963.7 3966.9 3366.3 3378.8 3382.1 3382.1 3391.0 4982.6 4983.7 4990.7 4997.2 5000.2 4237.5 4466.0 4469.3 4472.2 4476.7 5332.4 5347.9 5352.8 5360.1 5361.1 3703.9 3726.4 3745.9 3746.8 3752.5 5357.3 5578.2 5579.0 5587.3 5609.0 3808.6 3831.2 3831.6 3832.5 3841.3 3858.2 3860.3 3885.5 3896.2 3902.2 4433.4 4447.4 4477.5 4483.3 4491.5 5216.7 5356.6 5367.6 5373.2 5413.0 1319.0 1325.7 1331.2 1331.7 1339.5 821.3 834.1 854.4 863.9 866.9 4710.8 4713.3 4718.7 4733.7 4745.2 5451.4 5479.4 5496.5 5506.7 5526.7 4517.0 4672.5 4677.2 4685.4 4690.3 2894.7 2895.2 2911.3 2932.4 2946.7 5042.0 5105.9 5115.4 5121.3 5133.8 5325.2 5551.6 5583.2 5732.5 5747.6 5152.8 5177.6 5178.0 5190.9 5193.5 5566.0 5593.7 5595.8 5610.4 5621.7 5241.8 5470.9 5475.2 5507.8 5509.3 5164.7 5174.9 5180.4 5187.5 5207.9 3809.3 3841.1 3860.8 3863.9 3874.7 5411.0 5610.4 5613.8 5621.4 5623.4 5364.0 5390.7 5417.5 5445.2 5482.7 5243.5 5399.3 5401.6 5438.7 5459.6 5311.4 5312.9 5322.7 5340.3 5368.9 5147.9 5250.7 5394.8 5448.4 5451.3 5300.4 5321.2 5336.7 5337.2 5340.8 00:21:23 INFO - PROCESS | 4886 | 00:21:23 INFO - PROCESS | 4886 | [#5] yui.html Cycles:180 Average:17745.26 Median:24958.50 stddev:24713.12 (99.0%) stddev-sans-first:24749.28 00:21:23 INFO - PROCESS | 4886 | Values: 694.5 694.9 696.1 725.4 768.3 12905.7 13435.3 13614.5 13650.5 13681.6 13255.4 13381.1 13414.2 13419.0 13468.3 628.1 773.6 788.7 792.8 793.8 791.7 793.5 796.2 797.8 799.7 848.5 848.9 857.9 859.5 861.1 847.0 847.1 847.9 848.9 850.8 615.9 620.1 621.7 622.2 624.5 13380.7 13381.6 13407.2 13448.4 13474.9 13374.2 13550.3 13627.9 13881.1 14116.2 10133.4 10192.6 10337.5 10346.4 10354.4 3387.5 3397.8 3410.9 3434.2 3514.7 61580.7 61962.4 63353.4 64253.0 64330.4 10627.8 10682.9 10686.7 10798.8 10868.5 20121.1 20126.8 20129.3 20170.3 20209.7 6825.5 6928.4 6973.3 7082.8 7124.1 3865.1 3957.3 3967.4 4084.4 4088.6 3032.2 3138.3 3145.0 3154.0 3164.8 509.3 513.4 521.6 522.4 527.0 503.7 562.4 562.9 593.8 594.4 8031.0 8049.2 8346.9 8543.0 8603.6 505.5 534.6 567.0 577.6 601.4 3837.5 3956.6 4000.2 4045.9 4084.6 74790.6 77559.0 78611.2 87796.1 98805.0 49413.3 52266.7 85968.0 86750.6 86945.0 80575.6 82206.6 83132.0 83455.6 84552.0 8624.9 8690.9 8722.3 8894.6 9007.6 45672.3 46469.1 47967.8 47971.8 48407.5 68463.0 70762.6 71496.3 71923.0 72160.6 10962.2 10978.3 10984.7 11095.7 11411.0 11780.5 12038.2 12110.4 12224.3 12238.6 11770.0 12018.6 12089.2 12139.5 12441.9 12036.8 12066.6 12178.1 12183.1 12504.7 11384.9 11711.4 11890.9 12147.1 12524.3 9150.2 9274.3 9354.4 9505.9 9654.0 10009.7 10019.3 10199.6 10202.0 10341.6 00:21:23 INFO - PROCESS | 4886 | -------- Summary: end -------- 00:21:23 INFO - PROCESS | 4886 | 00:21:24 INFO - TEST-INFO | 4886: exit 0 00:21:24 INFO - TEST-OK | dromaeo_css | took 1115290ms 00:21:24 INFO - TEST-START | kraken 00:21:24 INFO - operating with platform_type : linux_ 00:21:24 INFO - Initialising browser for kraken test... 00:21:24 INFO - TEST-INFO | started process 5123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QMNSt/profile http://localhost:51489/getInfo.html) 00:21:28 INFO - PROCESS | 5123 | __metrics Screen width/height:1600/1200 00:21:28 INFO - PROCESS | 5123 | colorDepth:24 00:21:28 INFO - PROCESS | 5123 | Browser inner width/height: 1024/697 00:21:28 INFO - PROCESS | 5123 | __metrics 00:21:29 ERROR - PROCESS | 5123 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 00:21:30 INFO - TEST-INFO | 5123: exit 0 00:21:30 INFO - Browser initialized. 00:21:30 INFO - Running cycle 1/1 for kraken test... 00:21:30 INFO - TEST-INFO | started process 5242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QMNSt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:21:42 INFO - PROCESS | 5242 | RSS: Main: 169332736 00:21:42 INFO - PROCESS | 5242 | 00:21:44 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-beat-detection) 00:21:45 INFO - PROCESS | 5242 | RSS: Main: 174137344 00:21:45 INFO - PROCESS | 5242 | 00:21:48 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-dft) 00:21:49 INFO - PROCESS | 5242 | RSS: Main: 173989888 00:21:49 INFO - PROCESS | 5242 | 00:21:52 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-fft) 00:21:52 INFO - PROCESS | 5242 | RSS: Main: 169144320 00:21:52 INFO - PROCESS | 5242 | 00:21:54 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51489/tests/kraken/driver.html?testName=audio-oscillator) 00:21:55 INFO - PROCESS | 5242 | RSS: Main: 169336832 00:21:55 INFO - PROCESS | 5242 | 00:21:57 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:21:58 INFO - PROCESS | 5242 | RSS: Main: 169598976 00:21:58 INFO - PROCESS | 5242 | 00:22:01 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51489/tests/kraken/driver.html?testName=imaging-darkroom) 00:22:02 INFO - PROCESS | 5242 | RSS: Main: 169914368 00:22:02 INFO - PROCESS | 5242 | 00:22:05 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51489/tests/kraken/driver.html?testName=imaging-desaturate) 00:22:06 INFO - PROCESS | 5242 | RSS: Main: 167317504 00:22:06 INFO - PROCESS | 5242 | 00:22:09 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51489/tests/kraken/driver.html?testName=json-parse-financial) 00:22:09 INFO - PROCESS | 5242 | RSS: Main: 168677376 00:22:09 INFO - PROCESS | 5242 | 00:22:11 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:22:12 INFO - PROCESS | 5242 | RSS: Main: 169230336 00:22:12 INFO - PROCESS | 5242 | 00:22:14 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:22:14 INFO - PROCESS | 5242 | RSS: Main: 168857600 00:22:14 INFO - PROCESS | 5242 | 00:22:17 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:22:17 INFO - PROCESS | 5242 | RSS: Main: 169287680 00:22:17 INFO - PROCESS | 5242 | 00:22:20 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:22:21 INFO - PROCESS | 5242 | RSS: Main: 169975808 00:22:21 INFO - PROCESS | 5242 | 00:22:24 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:22:24 INFO - PROCESS | 5242 | RSS: Main: 169672704 00:22:24 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | Cycle 1(1): loaded http://localhost:51489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51489/tests/kraken/driver.html?testName=ai-astar) 00:22:26 INFO - PROCESS | 5242 | RSS: Main: 170819584 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | __start_tp_report 00:22:26 INFO - PROCESS | 5242 | _x_x_mozilla_page_load 00:22:26 INFO - PROCESS | 5242 | _x_x_mozilla_page_load_details 00:22:26 INFO - PROCESS | 5242 | |i|pagename|runs| 00:22:26 INFO - PROCESS | 5242 | |0;ai-astar;105;115;108;116;116;113;115;113;114;114 00:22:26 INFO - PROCESS | 5242 | |1;audio-beat-detection;160;137;161;182;135;159;156;138;188;133 00:22:26 INFO - PROCESS | 5242 | |2;audio-dft;164;164;165;174;164;164;163;166;165;164 00:22:26 INFO - PROCESS | 5242 | |3;audio-fft;77;75;77;164;77;77;76;77;163;78 00:22:26 INFO - PROCESS | 5242 | |4;audio-oscillator;88;88;157;86;87;93;132;87;85;134 00:22:26 INFO - PROCESS | 5242 | |5;imaging-gaussian-blur;118;119;117;117;118;118;118;118;119;118 00:22:26 INFO - PROCESS | 5242 | |6;imaging-darkroom;148;149;148;147;147;147;148;147;148;148 00:22:26 INFO - PROCESS | 5242 | |7;imaging-desaturate;95;96;95;96;95;96;95;96;95;96 00:22:26 INFO - PROCESS | 5242 | |8;json-parse-financial;64;69;65;67;66;65;68;66;67;66 00:22:26 INFO - PROCESS | 5242 | |9;json-stringify-tinderbox;65;65;67;67;68;66;65;65;65;64 00:22:26 INFO - PROCESS | 5242 | |10;stanford-crypto-aes;83;83;82;84;84;91;84;84;102;90 00:22:26 INFO - PROCESS | 5242 | |11;stanford-crypto-ccm;132;148;135;143;131;136;136;134;135;151 00:22:26 INFO - PROCESS | 5242 | |12;stanford-crypto-pbkdf2;173;171;170;172;166;170;169;168;176;167 00:22:26 INFO - PROCESS | 5242 | |13;stanford-crypto-sha256-iterative;67;69;68;67;66;67;66;70;67;67 00:22:26 INFO - PROCESS | 5242 | __end_tp_report 00:22:26 INFO - PROCESS | 5242 | __start_cc_report 00:22:26 INFO - PROCESS | 5242 | _x_x_mozilla_cycle_collect,986 00:22:26 INFO - PROCESS | 5242 | __end_cc_report 00:22:26 INFO - PROCESS | 5242 | __startTimestamp1467184946804__endTimestamp 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | ------- Summary: start ------- 00:22:26 INFO - PROCESS | 5242 | Number of tests: 14 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.50 stddev:3.60 (3.1%) stddev-sans-first:2.44 00:22:26 INFO - PROCESS | 5242 | Values: 105.0 115.0 108.0 116.0 116.0 113.0 115.0 113.0 114.0 114.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:159.50 stddev:19.42 (12.2%) stddev-sans-first:20.51 00:22:26 INFO - PROCESS | 5242 | Values: 160.0 137.0 161.0 182.0 135.0 159.0 156.0 138.0 188.0 133.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:3.16 (1.9%) stddev-sans-first:3.32 00:22:26 INFO - PROCESS | 5242 | Values: 164.0 164.0 165.0 174.0 164.0 164.0 163.0 166.0 165.0 164.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#3] audio-fft Cycles:10 Average:94.10 Median:77.00 stddev:36.59 (47.5%) stddev-sans-first:38.28 00:22:26 INFO - PROCESS | 5242 | Values: 77.0 75.0 77.0 164.0 77.0 77.0 76.0 77.0 163.0 78.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:87.00 stddev:26.64 (30.6%) stddev-sans-first:27.65 00:22:26 INFO - PROCESS | 5242 | Values: 88.0 88.0 157.0 86.0 87.0 93.0 132.0 87.0 85.0 134.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 00:22:26 INFO - PROCESS | 5242 | Values: 118.0 119.0 117.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 00:22:26 INFO - PROCESS | 5242 | Values: 148.0 149.0 148.0 147.0 147.0 147.0 148.0 147.0 148.0 148.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 00:22:26 INFO - PROCESS | 5242 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.50 stddev:1.49 (2.2%) stddev-sans-first:1.33 00:22:26 INFO - PROCESS | 5242 | Values: 64.0 69.0 65.0 67.0 66.0 65.0 68.0 66.0 67.0 66.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 00:22:26 INFO - PROCESS | 5242 | Values: 65.0 65.0 67.0 67.0 68.0 66.0 65.0 65.0 65.0 64.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:84.00 stddev:6.17 (7.3%) stddev-sans-first:6.39 00:22:26 INFO - PROCESS | 5242 | Values: 83.0 83.0 82.0 84.0 84.0 91.0 84.0 84.0 102.0 90.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:136.00 stddev:6.84 (5.0%) stddev-sans-first:6.89 00:22:26 INFO - PROCESS | 5242 | Values: 132.0 148.0 135.0 143.0 131.0 136.0 136.0 134.0 135.0 151.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.50 stddev:2.97 (1.7%) stddev-sans-first:2.98 00:22:26 INFO - PROCESS | 5242 | Values: 173.0 171.0 170.0 172.0 166.0 170.0 169.0 168.0 176.0 167.0 00:22:26 INFO - PROCESS | 5242 | 00:22:26 INFO - PROCESS | 5242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 00:22:26 INFO - PROCESS | 5242 | Values: 67.0 69.0 68.0 67.0 66.0 67.0 66.0 70.0 67.0 67.0 00:22:26 INFO - PROCESS | 5242 | -------- Summary: end -------- 00:22:26 INFO - PROCESS | 5242 | 00:22:27 INFO - TEST-INFO | 5242: exit 0 00:22:27 INFO - TEST-OK | kraken | took 63541ms 00:22:27 INFO - SUITE-END | took 1178s 00:22:27 INFO - Completed test suite (00:19:38) 00:22:27 INFO - javascript benchmark 00:22:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6356.876183381059, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.896764129435, 2629.3426643339158, 2676.611891275765, 2678.1028355500907, 2678.638383818185, 4718.5281471852795, 4759.643026772993, 4777.8088876444945, 4838.612910967123, 4851.22380419133, 4704.623630109591, 4793.544613261734, 4799.232122860343, 4854.101991131643, 4858.052679727454, 4361.411209486726, 4444.622207112399, 4513.165064463068, 4522.547745225467, 4538.750368729735, 551.9623807277321, 4315.158544083905, 4397.362382454542, 4412.051408947092, 4478.820847166109, 4414.668899832525, 4432.224360736875, 4451.821927122944, 4456.420665313521, 4493.7977790999485, 4428.800703968329, 4450.087732014929, 4455.376247325377, 4459.687821852472, 4474.328850672393, 4321.956780432187, 4384.978075109636, 4386.385905973167, 4411.139827733593, 4434.246178149722, 4735.810567577293, 4749.121412538691, 4813.446453657839, 4818.903621927542, 4883.0, 5159.458256883011, 5178.430372659004, 5213.556847667953, 5231.084560201949, 5258.211268309746, 5164.302819119408, 5200.141976573861, 5201.141811601081, 5218.921716174261, 5221.765020574046, 4821.325014497973, 4859.441164266119, 4874.09829181599, 4883.4628190898975, 4910.165271903785, 5138.743062846917, 5352.277442545284, 5379.1393377059485, 5401.189821526724, 5401.405845357008, 5124.8206312778875, 5168.405633352213, 5178.197379406198, 5189.325387699575, 5238.188080847474, 5235.240890070919, 5243.213517972335, 5244.606654500928, 5246.0, 5309.495597918191, 4941.283513890466, 5035.521625445577, 5118.0, 5154.0, 5164.225366195101, 5121.103806833789, 5141.897162056813, 5147.944671342366, 5150.768215430315, 5166.405863325691, 4442.2892337225885, 4474.373587697725, 4476.194285028661, 4477.90078551832, 4511.481179664315, 3774.75464094833, 3805.543334799842, 3822.445745366906, 3921.941170882439, 3932.0956180078742, 4383.561643835655, 4445.066536027406, 4446.444194475691, 4470.038941627566, 4496.887577810516, 5232.790688372498, 5233.973830130825, 5243.187305967581, 5248.868778280574, 5291.603129765206, 4395.934060989088, 4480.036792089716, 4484.618807401343, 4500.919779252956, 4552.317152427162, 4711.646626503026, 4713.34013238147, 4716.905661886812, 4727.101850648366, 4764.523547645277, 4818.349522814446, 4883.3651625288485, 4888.92666609994, 4898.53463920927, 4938.08645400602, 5047.41954675217, 5187.714675692873, 5219.425863155126, 5238.68567885928, 5261.0, 4848.903021939612, 4880.145974454385, 4887.951120488749, 4905.313256144072, 4944.48082951285, 5177.2492988515705, 5178.404483484447, 5183.300254465599, 5185.22221666753, 5191.428942816212, 5179.792808287626, 5196.376434827845, 5214.2960700304975, 5255.842324730264, 5266.473352664703, 5055.545000949932, 5111.309973153577, 5119.590432765444, 5120.974395128001, 5162.6386152968935, 4893.584045356185, 4988.102141614544, 5044.974775126101, 5053.898922021613, 5082.2122571001555, 4954.405471343462, 4965.577925876341, 4971.751412429292, 4980.601551875914, 5051.191809310492, 5043.142665746906, 5051.166557517969, 5060.797568097235, 5107.974460127675, 5110.284560161655, 4952.8761780955765, 4983.800647974041, 4986.390310900238, 4991.850244492671, 5040.14317566022], "value": 4734.280457291907, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.511266264678, 590.4626789621445, 594.274984518887, 602.8402473344568, 604.3171216525327, 33828.49257261143, 37599.872003839926, 37619.247615047716, 37653.43519847204, 37753.622463775355, 38195.61804381955, 39061.414078788766, 39130.608693913055, 39279.21441571167, 39302.21395572094, 7688.154303026663, 7771.961140194319, 7784.26049525297, 7833.334166595846, 7844.450888437812, 7743.574103424309, 7754.302112809846, 7775.844483110334, 7779.805504862367, 7814.609269536529, 7823.295903368696, 7823.608819559027, 7833.177516360785, 7894.802629934269, 7925.2867241948215, 7747.806304842367, 7794.298513133816, 7818.45270831042, 7850.057993040871, 7873.921260787405, 7754.612269386508, 7821.921780782176, 7829.686812527492, 7839.294463498312, 7849.45053846231, 36319.63680363215, 36720.0, 36739.816300918326, 36760.63239367626, 36778.264434711426, 3097.566340712302, 3233.951490727641, 3279.7868138570916, 3378.0879162626197, 3544.220271540257, 29526.704732952825, 29879.0, 30014.399712005637, 30029.0, 30243.546346804815, 3511.7190624750215, 3598.4242521196484, 3603.0632035670915, 3606.963930360689, 3673.651003154696, 255039.0, 255642.0, 256764.0, 256981.99999999814, 257531.0, 31509.369812603618, 51314.74342628338, 51345.0, 51746.74126629343, 51768.22347664788, 32356.22040787732, 33749.49375759366, 33934.32131357359, 34046.82976585151, 34096.0, 11544.711382215512, 11605.419729013516, 11616.825747613793, 11638.301701897914, 11643.941780291045, 10174.186065114773, 10249.33379330341, 10252.179825613934, 10261.230407719451, 10263.846042309371, 7793.220677932275, 7842.176571460029, 7872.370210383156, 7986.680532778624, 7987.680492780224, 3181.427343078222, 3181.602299712536, 3200.3279311344413, 3205.1346136543, 3209.1335339458683, 863.9222469977732, 918.8162367526521, 959.3572306554626, 959.5154447004358, 963.6145541783343, 27652.096529864477, 28374.0, 28675.0, 28849.423011539653, 29039.854800726283, 886.4061079077034, 956.9521523923776, 978.4031740638205, 1005.5625802775816, 1046.576136664652, 14528.491502797351, 14797.260136993107, 14847.70304593902, 14959.102453852804, 15160.545183644508, 367961.0, 373655.0, 373916.0, 373958.0, 375056.0, 49936.250956235686, 50022.0, 50271.49728502741, 50281.0, 50332.74833625808, 1149.1668540308376, 1156.4738044189874, 1173.6537721372044, 1175.3476820364779, 1188.3226560860398, 26254.606180907685, 27815.16554503368, 27818.30454238579, 28140.296492587848, 28145.43709125847, 41745.16509669729, 41949.370759438025, 42089.78955105205, 42196.789016054725, 42260.78869605633, 316970.0, 318049.0, 320988.0, 322742.0, 323145.0, 22467.10131594783, 23056.884715576987, 25139.87430062911, 25743.485130297664, 25856.0, 41766.791166045194, 42041.78979105207, 42733.0, 42754.78622606867, 43309.13381732284, 35900.28199436049, 36694.44958325574, 36793.816030919676, 36809.0, 37011.6298837019, 35625.82187089048, 36147.819260903525, 36187.0, 36261.45607815832, 36389.454158187116, 30848.0, 34842.12894677653, 35894.641053590174, 35966.820165899, 36954.26091478209, 32134.517982230755, 33185.83407082949, 33564.496532551544, 33745.0, 33825.0, 21510.677339839604, 22107.22624708192, 22251.888740556195, 25247.0, 25891.61162582525], "value": 16329.516688817474, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.93946059439594, 353.10487913140184, 355.81675437149863, 358.9389803733365, 364.75379119094623, 15946.760798588031, 16785.24466399012, 16926.74609880853, 17243.396481123164, 17263.48209553712, 16039.759403608956, 16387.754183687255, 16951.32194712213, 17030.914845425785, 17037.403690870822, 5002.799888004475, 5159.845204643867, 5201.167813149897, 5203.19350500673, 5205.245239440298, 3678.521792167028, 5110.846674599749, 5813.215215945836, 6139.7851075212375, 6156.476699480527, 6153.35389784073, 6156.876862462748, 6178.783742569011, 6200.224971878515, 6207.379262073801, 5019.573336266421, 5352.598555108363, 5354.892902141954, 5394.406615272317, 5397.892042159174, 5243.895122097575, 5250.264962905197, 5419.810306639288, 5421.9457805421835, 5422.105352616813, 19739.40781776549, 19835.305764298326, 19928.90035549813, 20150.798492015037, 20357.592848143104, 1932.4492519631838, 1959.9216031358872, 1960.2257108442086, 2137.2840098567, 2323.6863023491783, 9042.276617870555, 9047.276217902552, 9127.634894604207, 9265.490398028105, 9452.95273523628, 1701.0219124003747, 1713.4516954574542, 1718.0550697116537, 1779.4394765648779, 1815.3646223821688, 65430.67284663594, 67684.6615766918, 67865.66067169633, 68413.65793171052, 69453.3054669452, 9608.2793790466, 9821.165200958, 9956.333623110164, 10026.09765121128, 10150.0, 13610.727785444236, 13662.52181173674, 13763.174209547258, 13769.449222031208, 13797.310134493235, 6963.4777391695825, 7000.159980802337, 7012.614306213105, 7194.568325900463, 7208.56748595086, 6617.43751781104, 6652.567583107082, 6705.798826035227, 6778.051072849805, 6869.519133660696, 4238.385434112037, 4243.384709217146, 4268.381084742695, 4314.6548276138465, 4361.2367835629275, 1659.6182877938143, 1671.5094509181233, 1782.5989152440857, 1798.9640207195782, 1811.673898698247, 372.4115896882918, 400.9959900400959, 415.775481240133, 839.8194388206565, 865.883010915924, 10355.741106472247, 10374.17006639467, 10417.479126043667, 10567.313124646873, 10612.681619551426, 399.6830443687997, 813.4265342933218, 833.9791505212297, 893.7586851550045, 910.8770316007254, 9101.40840845343, 9134.778699170667, 9218.53907304632, 9265.629374824932, 9319.720408387759, 382781.0, 392483.0, 417733.0, 435368.0, 435691.0, 49365.0, 70706.9393959091, 81072.59463702762, 82169.58915205386, 83857.58071209605, 924.5284904698518, 929.7815013471828, 954.4845783276953, 958.1616085924816, 969.4231932000448, 14474.256272893952, 14474.27628618586, 14674.192919389536, 14717.705645887236, 14816.333265003317, 34463.72594603508, 35319.646803531636, 35370.0, 36938.630613693516, 38018.80990595029, 53138.0, 54220.0, 54356.728216358664, 54409.183862241305, 54513.72743136259, 6446.806595802133, 6738.7304507819135, 6866.279040700654, 6902.654867256517, 6935.237123916264, 10613.575456981634, 11785.116116291483, 11968.700782480508, 12050.879491204976, 12342.50629974827, 9132.360734748503, 9252.907470925205, 9358.204552613104, 9573.090556397132, 9650.276229282692, 10134.695959121238, 10188.337758045704, 10372.74068148272, 10423.68728938133, 10436.739081523023, 9352.251819854531, 9577.042295770645, 9765.511724413893, 9852.507374631097, 9945.403275803475, 6913.792586222421, 6915.101036865175, 6929.792106236821, 7022.613756243456, 7080.964595176991, 7335.559866408033, 8437.915620843713, 9207.86188207164, 9292.58183381763, 9720.902790972283], "value": 7859.705060329985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.4518192722912, 1389.7845833895744, 1468.581454285529, 1633.7631043498686, 1664.1097013097994, 6497.90253146202, 7246.673899674514, 7324.48728588999, 7746.0317460317465, 7752.844943101135, 7452.180260171391, 7595.164531901486, 7667.42494312926, 7676.117246516652, 7689.807754806133, 2163.1996161420257, 2196.077647388101, 2197.154095673169, 2199.49411635324, 2202.9559408811815, 2144.1744928202597, 2175.1516908405656, 2178.106976139783, 2180.0, 2183.7488688800754, 2165.9350219493363, 2196.187410658059, 2206.977930220701, 2207.5915955548276, 2208.1277895231374, 2100.306898723425, 2120.204923153817, 2125.628015097367, 2125.6492678707996, 2145.753238377591, 2008.9095990680455, 2015.2745011795741, 2084.6143463459307, 2104.5054412213117, 2106.9051892664716, 7669.079710434784, 7679.308862202429, 7689.538627682357, 7714.459987800856, 7731.188225236326, 4313.698041137121, 4460.643148548108, 4462.598366147063, 4462.620677242438, 4463.866084017484, 2834.6598408190944, 2934.457125431802, 2994.386150839073, 3020.7734419918593, 3032.8938487152845, 929.8140371925574, 952.8618350339232, 972.9951350243203, 973.6397532912868, 986.8322385194534, 10188.694339169837, 10211.79576408475, 10222.131118854906, 10245.89754102457, 10279.743006424824, 3984.183242435352, 4009.69927255457, 4097.037196258877, 4124.979375103166, 4125.525564560054, 8847.292216622654, 8859.24696400813, 8864.20222180007, 8875.068117847663, 8879.42283751567, 4411.536788637211, 4428.800703968329, 4434.556544345604, 4447.132809102259, 4448.377227188196, 3464.428369319034, 3879.2047630235734, 4042.3734321180264, 4089.5092588889524, 4092.3656833190903, 3438.6045604755773, 3580.427131658922, 3618.782873027627, 3637.0543658648944, 3662.377395842713, 1110.655696734015, 1129.0854407929603, 1140.8402823604536, 1153.0, 1153.5385845661635, 817.9509229446252, 824.5959479854828, 836.9788857593726, 853.7396094191331, 854.1927878155084, 4859.2954021667365, 4988.176950803077, 5118.0, 5130.769115389817, 5264.078786212397, 868.405142477405, 889.573004957624, 907.3648446087765, 926.2127191886842, 930.497531333086, 3331.0, 3444.2594842108565, 3465.428204346305, 3501.9124521887156, 3511.0695665648623, 9146.90853091474, 9313.487758173365, 9378.85931711025, 9380.061993800566, 9434.528273586293, 9308.162265396148, 9333.673321433716, 9348.205402540723, 9380.296477764196, 9434.764130896645, 6788.93211067883, 6884.931150688429, 6941.618210998343, 6951.756688515878, 7059.647017649097, 5039.672421292605, 5165.380154381348, 5172.482751724798, 5207.739613019258, 5341.038613049533, 8400.579971001303, 8468.280196183394, 8522.573871306286, 8528.317734581342, 8528.786780330542, 8270.83458330818, 8629.913700863162, 8637.69768058115, 8738.475691458532, 8808.51553164582, 5878.764849405976, 6377.947638639758, 6635.535512514078, 6735.393814556517, 6884.173899132136, 7462.813429664085, 7492.0, 7505.136909255505, 7524.962375188089, 7545.094588649177, 6536.7712130075215, 6840.589564626139, 6841.076454678555, 6886.51794374389, 6916.273791251846, 6606.8017959461295, 6610.10763546915, 6660.666966651745, 6716.059751634873, 6766.695498702472, 6064.3935606439, 6144.662043587646, 6145.877082458415, 6210.099535567408, 6217.036359364306, 4394.538573449741, 4414.381986521954, 4442.73343599385, 4460.420145381079, 4463.509014008521, 4425.203463376494, 4454.532274111171, 4463.085067561207, 4474.664400170065, 4519.028408892104], "value": 4059.9068797974032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.18770537989354, 299.7467140266474, 301.3490859742955, 303.375047402351, 303.79493841656875, 5141.8457446276625, 5147.0, 5163.767630456629, 5177.896442071156, 5184.326037615109, 5106.1574840151425, 5109.795608175668, 5110.463401342852, 5134.382669459118, 5149.098907691157, 3831.9042023949414, 3852.4012534798167, 3961.2671655743634, 3981.5222173339093, 3981.6217459341315, 3964.781936993464, 3972.695836414887, 3975.5030621172355, 3980.3631418972827, 3987.421823835542, 3956.3076461619244, 3957.267905437489, 3959.6832253419802, 3959.762414255154, 3963.425303331015, 3689.2252626948375, 3908.1597456546697, 3922.372420412749, 3963.702722295825, 3966.9008274793073, 3366.276250606107, 3378.847951842173, 3382.0868365541164, 3382.0868365541414, 3390.9830450847835, 4982.551570358685, 4983.72589507577, 4990.65065445419, 4997.2004479283505, 5000.174971129759, 4237.470316210473, 4465.977670111661, 4469.3296005599095, 4472.1502914446155, 4476.664250181249, 5332.3601167859715, 5347.850212204395, 5352.84913743547, 5360.115580929142, 5361.142217245261, 3703.925921481582, 3726.366517691999, 3745.925081498382, 3746.7939263340504, 3752.4934133891848, 5357.303550538405, 5578.163275508666, 5578.972105139448, 5587.273654424939, 5608.971955140239, 3808.638179372955, 3831.1571454280015, 3831.5593706723525, 3832.463455116286, 3841.3085644583684, 3858.151206734514, 3860.343741563941, 3885.533735951704, 3896.1818018215927, 3902.1610353774076, 4433.359656926893, 4447.399601053881, 4477.462704475483, 4483.30508771141, 4491.483479399845, 5216.66091704038, 5356.571474282048, 5367.570594352521, 5373.194020896819, 5413.025655382069, 1318.967025824343, 1325.6544607223675, 1331.1946272504995, 1331.7203387288585, 1339.4642143142626, 821.3018933906131, 834.0533494483805, 854.4189950833493, 863.8704194370895, 866.8743032260287, 4710.764461776897, 4713.336964614981, 4718.669693121448, 4733.715977041388, 4745.217039188496, 5451.37309209446, 5479.397266300703, 5496.4503549645515, 5506.669599824023, 5526.696031718214, 4517.043752620927, 4672.462666793363, 4677.22825733757, 4685.390899183084, 4690.296455531698, 2894.7105289470883, 2895.1604034829666, 2911.344947386863, 2932.3548819259727, 2946.6758656547763, 5042.0, 5105.9489405106215, 5115.360579927509, 5121.308623335802, 5133.820316288987, 5325.174597937326, 5551.583631227674, 5583.162525621189, 5732.484076433141, 5747.5689323300085, 5152.819651312186, 5177.585793136615, 5178.0, 5190.896182076337, 5193.480651934852, 5565.9721701392855, 5593.748281327269, 5595.804146854841, 5610.410906854721, 5621.74702138413, 5241.828693640293, 5470.863228419322, 5475.178723191394, 5507.779688812403, 5509.311336082989, 5164.690118592896, 5174.896502069862, 5180.352455943007, 5187.4553171916405, 5207.895842083213, 3809.2573347189978, 3841.0973421246545, 3860.8069596520622, 3863.922721545497, 3874.690024797953, 5411.0, 5610.354809196831, 5613.775448982158, 5621.442243779153, 5623.409541998195, 5364.042124624562, 5390.676559406448, 5417.458254174551, 5445.230300152387, 5482.671039737628, 5243.501867322599, 5399.271098401822, 5401.6218864679095, 5438.700871452108, 5459.645123066988, 5311.415744268204, 5312.867178320573, 5322.733863306897, 5340.344493207118, 5368.892622147457, 5147.948520514897, 5250.684958902478, 5394.838154855361, 5448.400675925565, 5451.291332126798, 5300.416954135119, 5321.175217841241, 5336.74586472171, 5337.226102215234, 5340.786368545215], "value": 4005.2836963037284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.4999600287792, 694.8506071194694, 696.1402667705383, 725.3979197266269, 768.281656651031, 12905.741885162302, 13435.328233588318, 13614.523491677794, 13650.522231721892, 13681.589552313446, 13255.40350684219, 13381.130226535293, 13414.195148291084, 13419.0, 13468.25924574148, 628.0641843652948, 773.6441237030973, 788.668759121169, 792.8176519400541, 793.8372633610096, 791.7426836278232, 793.5040599625235, 796.1719811396141, 797.8364435290752, 799.6801279488222, 848.4739461533858, 848.9278411335044, 857.9313654907593, 859.5229647545609, 861.0915484164204, 846.9788255293605, 847.1443841719877, 847.8643417053273, 848.9193526614962, 850.7873031742065, 615.8983767678328, 620.0915658560231, 621.6767281013847, 622.1662971618053, 624.4692011789988, 13380.665483362995, 13381.598552043455, 13407.195568265837, 13448.394822233024, 13474.865251347459, 13374.197548147142, 13550.254735989516, 13627.931860340734, 13881.097728647606, 14116.223607701573, 10133.391996480235, 10192.59229630814, 10337.483125843677, 10346.379217246915, 10354.430506322149, 3387.491876218562, 3397.8301084945656, 3410.9488357674654, 3434.244466217428, 3514.68367846895, 61580.69209653968, 61962.38037619611, 63353.36646633521, 64253.0, 64330.35669643291, 10627.84058239127, 10682.946585267024, 10686.679399618024, 10798.838017429745, 10868.510917008754, 20121.0884965928, 20126.798732012492, 20129.295474658316, 20170.29403970854, 20209.696854547194, 6825.522213445011, 6928.44572434204, 6973.267806880306, 7082.822929426702, 7124.073870396815, 3865.1496670732395, 3957.3272543667645, 3967.3652215645357, 4084.36692312692, 4088.632023117934, 3032.2267821705764, 3138.262508310591, 3144.9685503145133, 3154.022253101546, 3164.7784655073924, 509.2564855311287, 513.383939272874, 521.6061873285645, 522.3914140026826, 527.0276340152412, 503.7405736045939, 562.3673367461606, 562.8958642651122, 593.795140676466, 594.3580932592789, 8031.0, 8049.235322644339, 8346.874796878052, 8543.0, 8603.612837422332, 505.5147058823497, 534.6257619666171, 567.0, 577.6072270855858, 601.3745704467304, 3837.520309961255, 3956.6043395660204, 4000.179963107556, 4045.8988525287104, 4084.6323830855367, 74790.62604686942, 77559.0, 78611.21388786154, 87796.12203878007, 98805.0, 49413.25880111801, 52266.73866630719, 85968.0, 86750.56624716836, 86945.0, 80575.59712201402, 82206.58896705598, 83132.0, 83455.58272208722, 84552.0, 8624.870626940476, 8690.869636955324, 8722.25860801839, 8894.59974301171, 9007.594658240263, 45672.31491527563, 46469.07061858811, 47967.760161198974, 47971.76014119907, 48407.51592484171, 68463.0, 70762.64618676873, 71496.28503714896, 71923.0, 72160.63919680368, 10962.177836662442, 10978.341299522055, 10984.670459886216, 11095.667129986114, 11411.0, 11780.469878855643, 12038.187634432526, 12110.414077745118, 12224.327661978676, 12238.571649992207, 11770.0, 12018.579349722717, 12089.15375923677, 12139.453724582592, 12441.937790311353, 12036.75926481483, 12066.577669781516, 12178.08664350195, 12183.147179697691, 12504.749905001667, 11384.886151138382, 11711.414429278673, 11890.881091188978, 12147.149699521302, 12524.311162886128, 9150.22223111043, 9274.304427167854, 9354.362986477476, 9505.857412138685, 9654.03459654029, 10009.69970900874, 10019.298649094493, 10199.592016319264, 10202.0, 10341.586336546454], "value": 6677.8321938668805, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 108.0, 116.0, 116.0, 113.0, 115.0, 113.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 137.0, 161.0, 182.0, 135.0, 159.0, 156.0, 138.0, 188.0, 133.0], "value": 154.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 174.0, 164.0, 164.0, 163.0, 166.0, 165.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 164.0, 77.0, 77.0, 76.0, 77.0, 163.0, 78.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 157.0, 86.0, 87.0, 93.0, 132.0, 87.0, 85.0, 134.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 65.0, 67.0, 66.0, 65.0, 68.0, 66.0, 67.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 67.0, 68.0, 66.0, 65.0, 65.0, 65.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 84.0, 84.0, 91.0, 84.0, 84.0, 102.0, 90.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 148.0, 135.0, 143.0, 131.0, 136.0, 136.0, 134.0, 135.0, 151.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 170.0, 172.0, 166.0, 170.0, 169.0, 168.0, 176.0, 167.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 67.0, 66.0, 67.0, 66.0, 70.0, 67.0, 67.0], "value": 67.4, "unit": "score"}]}]} 00:22:28 INFO - Return code: 0 00:22:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:22:28 ERROR - # TBPL SUCCESS # 00:22:28 INFO - Running post-action listener: _resource_record_post_action 00:22:28 INFO - ##### 00:22:28 INFO - ##### Finished run-tests step (success) 00:22:28 INFO - ##### 00:22:28 INFO - Running post-run listener: _resource_record_post_run 00:22:28 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551354368; Read time: 16; Write time: 524116 00:22:28 INFO - TinderboxPrint: CPU usage
13.4% 00:22:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:22:28 INFO - TinderboxPrint: I/O write bytes / time
551,354,368 / 524,116 00:22:28 INFO - TinderboxPrint: CPU idle
8,261.2 (86.6%) 00:22:28 INFO - TinderboxPrint: CPU user
1,228.8 (12.9%) 00:22:28 INFO - TinderboxPrint: Swap in / out
0 / 0 00:22:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262385664; Read time: 0; Write time: 298272 00:22:28 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288755712; Read time: 16; Write time: 225820 00:22:28 INFO - Running post-run listener: _upload_blobber_files 00:22:28 INFO - Blob upload gear active. 00:22:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:22:28 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 00:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:22:29 INFO - (blobuploader) - INFO - Open directory for files ... 00:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:22:30 INFO - (blobuploader) - INFO - Done attempting. 00:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:22:30 INFO - (blobuploader) - INFO - Done attempting. 00:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:22:34 INFO - (blobuploader) - INFO - Done attempting. 00:22:34 INFO - (blobuploader) - INFO - Iteration through files over. 00:22:34 INFO - Return code: 0 00:22:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:22:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:22:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c757e3210a9a6c23dde7566a0e8d45892225417bdfad144f7c556244b11d22bf5fb7b4e538a1f0629b4009436d785518300d4d06f2afa026b23943d116ce7d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e6821bc5fe40d7b23c6233319736f7e966c035e0f8ba8f037756cafbc5e2530eeed161862f16150a350cfc8b074137d8a1a03351a060f4bcf323a44a77a97fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac37471fa724da1e585cdca2d028476f2476fef21da5b1d6cd42b17f68ff47cbfa30cae63ceed661b48f162d587eca5fc3a5814851fa455b9470df8e5383013"} 00:22:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:22:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:22:34 INFO - Contents: 00:22:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c757e3210a9a6c23dde7566a0e8d45892225417bdfad144f7c556244b11d22bf5fb7b4e538a1f0629b4009436d785518300d4d06f2afa026b23943d116ce7d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e6821bc5fe40d7b23c6233319736f7e966c035e0f8ba8f037756cafbc5e2530eeed161862f16150a350cfc8b074137d8a1a03351a060f4bcf323a44a77a97fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac37471fa724da1e585cdca2d028476f2476fef21da5b1d6cd42b17f68ff47cbfa30cae63ceed661b48f162d587eca5fc3a5814851fa455b9470df8e5383013"} 00:22:34 INFO - Running post-run listener: copy_logs_to_upload_dir 00:22:34 INFO - Copying logs to upload dir... 00:22:34 INFO - mkdir: /builds/slave/test/build/upload/logs 00:22:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.672804 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-29 00:22:33.791775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 00:22:33.795601) ========= 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=0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c757e3210a9a6c23dde7566a0e8d45892225417bdfad144f7c556244b11d22bf5fb7b4e538a1f0629b4009436d785518300d4d06f2afa026b23943d116ce7d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e6821bc5fe40d7b23c6233319736f7e966c035e0f8ba8f037756cafbc5e2530eeed161862f16150a350cfc8b074137d8a1a03351a060f4bcf323a44a77a97fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac37471fa724da1e585cdca2d028476f2476fef21da5b1d6cd42b17f68ff47cbfa30cae63ceed661b48f162d587eca5fc3a5814851fa455b9470df8e5383013"} build_url:https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/bxEmz13SSuC0XLVX_wcucw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c757e3210a9a6c23dde7566a0e8d45892225417bdfad144f7c556244b11d22bf5fb7b4e538a1f0629b4009436d785518300d4d06f2afa026b23943d116ce7d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e6821bc5fe40d7b23c6233319736f7e966c035e0f8ba8f037756cafbc5e2530eeed161862f16150a350cfc8b074137d8a1a03351a060f4bcf323a44a77a97fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dac37471fa724da1e585cdca2d028476f2476fef21da5b1d6cd42b17f68ff47cbfa30cae63ceed661b48f162d587eca5fc3a5814851fa455b9470df8e5383013"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 00:22:33.822090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:22:33.822482) ========= 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=0333a256a5e4f052382dd180000001b1-1467179480.961131-283122734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:22:33.904849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 00:22:33.905243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 00:22:33.905717) ========= ========= Total master_lag: 0.18 =========