builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1468379878.78 results: success (0) buildid: 20160712173003 builduid: 199aace65d89456ab247c0f922ecf6d6 revision: 0d7a788f1c40adf5038505e25e600d8551dbda06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:58.779402) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:58.780063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:58.780369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:58.830487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:58.830764) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 20:17: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-07-12 20:17:58 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:58.968040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:58.968358) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017954 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:59.017910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:59.018389) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d7a788f1c40adf5038505e25e600d8551dbda06 --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 0d7a788f1c40adf5038505e25e600d8551dbda06 --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=56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 20:17:59,050 truncating revision to first 12 chars 2016-07-12 20:17:59,050 Setting DEBUG logging. 2016-07-12 20:17:59,050 attempt 1/10 2016-07-12 20:17:59,050 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d7a788f1c40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 20:17:59,675 unpacking tar archive at: fx-team-0d7a788f1c40/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:59.976018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:59.976388) ========= script_repo_revision: 0d7a788f1c40adf5038505e25e600d8551dbda06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:59.976842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:59.977148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 20:17:59.991310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-12 20:17:59.991994) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:18:00 INFO - MultiFileLogger online at 20160712 20:18:00 in /builds/slave/test 20:18:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:18:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:18:00 INFO - {'append_to_log': False, 20:18:00 INFO - 'base_work_dir': '/builds/slave/test', 20:18:00 INFO - 'blob_upload_branch': 'Fx-Team', 20:18:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:18:00 INFO - 'branch': 'Fx-Team', 20:18:00 INFO - 'buildbot_json_path': 'buildprops.json', 20:18:00 INFO - 'config_files': ('talos/linux_config.py',), 20:18:00 INFO - 'default_actions': ('clobber', 20:18:00 INFO - 'read-buildbot-config', 20:18:00 INFO - 'download-and-extract', 20:18:00 INFO - 'populate-webroot', 20:18:00 INFO - 'create-virtualenv', 20:18:00 INFO - 'install', 20:18:00 INFO - 'run-tests'), 20:18:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:18:00 INFO - 'download_minidump_stackwalk': True, 20:18:00 INFO - 'download_symbols': 'ondemand', 20:18:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:18:00 INFO - 'tooltool.py': '/tools/tooltool.py', 20:18:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:18:00 INFO - '/tools/misc-python/virtualenv.py')}, 20:18:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:18:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:18:00 INFO - 'installer_path': 'installer.exe', 20:18:00 INFO - 'log_level': 'info', 20:18:00 INFO - 'log_name': 'talos', 20:18:00 INFO - 'log_to_console': True, 20:18:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:18:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:18:00 INFO - 'opt_config_files': (), 20:18:00 INFO - 'pip_index': False, 20:18:00 INFO - 'sps_profile': False, 20:18:00 INFO - 'sps_profile_interval': 0, 20:18:00 INFO - 'suite': 'dromaeojs-e10s', 20:18:00 INFO - 'system_bits': '32', 20:18:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:18:00 INFO - 'title': 'talos-linux64-ix-037', 20:18:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:18:00 INFO - 'use_talos_json': True, 20:18:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:18:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:18:00 INFO - 'work_dir': 'build'} 20:18:00 INFO - ##### 20:18:00 INFO - ##### Running clobber step. 20:18:00 INFO - ##### 20:18:00 INFO - Running pre-action listener: _resource_record_pre_action 20:18:00 INFO - Running main action method: clobber 20:18:00 INFO - rmtree: /builds/slave/test/build 20:18:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:18:00 INFO - Running post-action listener: _resource_record_post_action 20:18:00 INFO - ##### 20:18:00 INFO - ##### Finished clobber step (success) 20:18:00 INFO - ##### 20:18:00 INFO - ##### 20:18:00 INFO - ##### Running read-buildbot-config step. 20:18:00 INFO - ##### 20:18:00 INFO - Running pre-action listener: _resource_record_pre_action 20:18:00 INFO - Running main action method: read_buildbot_config 20:18:00 INFO - Using buildbot properties: 20:18:00 INFO - { 20:18:00 INFO - "project": "", 20:18:00 INFO - "product": "firefox", 20:18:00 INFO - "script_repo_revision": "production", 20:18:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:18:00 INFO - "repository": "", 20:18:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:18:00 INFO - "buildid": "20160712173003", 20:18:00 INFO - "pgo_build": "True", 20:18:00 INFO - "basedir": "/builds/slave/test", 20:18:00 INFO - "buildnumber": 614, 20:18:00 INFO - "slavename": "talos-linux64-ix-037", 20:18:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:18:00 INFO - "platform": "ubuntu64_hw", 20:18:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:18:00 INFO - "branch": "fx-team", 20:18:00 INFO - "repo_path": "integration/fx-team", 20:18:00 INFO - "revision": "0d7a788f1c40adf5038505e25e600d8551dbda06", 20:18:00 INFO - "stage_platform": "linux64-pgo", 20:18:00 INFO - "builduid": "199aace65d89456ab247c0f922ecf6d6", 20:18:00 INFO - "slavebuilddir": "test" 20:18:00 INFO - } 20:18:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:18:00 INFO - Running post-action listener: _resource_record_post_action 20:18:00 INFO - ##### 20:18:00 INFO - ##### Finished read-buildbot-config step (success) 20:18:00 INFO - ##### 20:18:00 INFO - ##### 20:18:00 INFO - ##### Running download-and-extract step. 20:18:00 INFO - ##### 20:18:00 INFO - Running pre-action listener: _resource_record_pre_action 20:18:00 INFO - Running main action method: download_and_extract 20:18:00 INFO - mkdir: /builds/slave/test/build/tests 20:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:00 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:02 INFO - Downloaded 1361 bytes. 20:18:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:18:02 INFO - Using the following test package requirements: 20:18:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:18:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:18:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'jsshell-linux-x86_64.zip'], 20:18:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:18:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:18:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:18:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:18:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:18:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:18:02 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')]} 20:18:02 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:03 INFO - Downloaded 24320640 bytes. 20:18:03 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'] 20:18:03 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 20:18:04 INFO - Return code: 0 20:18: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 20:18: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')]} 20:18:04 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:22 INFO - Downloaded 24320640 bytes. 20:18:22 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'] 20:18:22 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 20:18:24 INFO - Return code: 0 20:18: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')]} 20:18:24 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:25 INFO - Downloaded 14403317 bytes. 20:18:25 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'] 20:18:25 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 20:18:25 INFO - Return code: 0 20:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:18:25 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:18:26 INFO - Downloaded 60775780 bytes. 20:18:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:18:26 INFO - mkdir: /builds/slave/test/properties 20:18:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:18:26 INFO - Writing to file /builds/slave/test/properties/build_url 20:18:26 INFO - Contents: 20:18:26 INFO - build_url:https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:18:27 INFO - Running post-action listener: _resource_record_post_action 20:18:27 INFO - Running post-action listener: set_extra_try_arguments 20:18:27 INFO - ##### 20:18:27 INFO - ##### Finished download-and-extract step (success) 20:18:27 INFO - ##### 20:18:27 INFO - ##### 20:18:27 INFO - ##### Running populate-webroot step. 20:18:27 INFO - ##### 20:18:27 INFO - Running pre-action listener: _resource_record_pre_action 20:18:27 INFO - Running main action method: populate_webroot 20:18:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:18:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:18:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:18:27 INFO - '--tppagecycles', 20:18:27 INFO - '7'], 20:18:27 INFO - 'tests': ['tsvgm']}}, 20:18:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:18:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:18:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:18:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:18:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['damp', 'tps']}, 20:18:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'tests': ['damp', 'tps']}, 20:18:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['dromaeo_dom']}, 20:18:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:18:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['basic_compositor_video']}, 20:18:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:18:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['a11yr', 20:18:27 INFO - 'ts_paint', 20:18:27 INFO - 'tpaint', 20:18:27 INFO - 'sessionrestore', 20:18:27 INFO - 'sessionrestore_no_auto_restore', 20:18:27 INFO - 'tabpaint']}, 20:18:27 INFO - 'other-e10s': {'tests': ['a11yr', 20:18:27 INFO - 'ts_paint', 20:18:27 INFO - 'tpaint', 20:18:27 INFO - 'sessionrestore', 20:18:27 INFO - 'sessionrestore_no_auto_restore', 20:18:27 INFO - 'tabpaint']}, 20:18:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:18:27 INFO - 'ts_paint', 20:18:27 INFO - 'tpaint', 20:18:27 INFO - 'sessionrestore', 20:18:27 INFO - 'sessionrestore_no_auto_restore', 20:18:27 INFO - 'tabpaint']}, 20:18:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:18:27 INFO - 'ts_paint', 20:18:27 INFO - 'tpaint', 20:18:27 INFO - 'sessionrestore', 20:18:27 INFO - 'sessionrestore_no_auto_restore', 20:18:27 INFO - 'tabpaint']}, 20:18:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['a11yr', 20:18:27 INFO - 'ts_paint', 20:18:27 INFO - 'tpaint', 20:18:27 INFO - 'sessionrestore', 20:18:27 INFO - 'sessionrestore_no_auto_restore', 20:18:27 INFO - 'tabpaint']}, 20:18:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['a11yr', 20:18:27 INFO - 'ts_paint', 20:18:27 INFO - 'tpaint', 20:18:27 INFO - 'sessionrestore', 20:18:27 INFO - 'sessionrestore_no_auto_restore', 20:18:27 INFO - 'tabpaint']}, 20:18:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['tsvgx', 20:18:27 INFO - 'tsvgr_opacity', 20:18:27 INFO - 'tart', 20:18:27 INFO - 'tscrollx', 20:18:27 INFO - 'cart']}, 20:18:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:18:27 INFO - 'tsvgr_opacity', 20:18:27 INFO - 'tart', 20:18:27 INFO - 'tscrollx', 20:18:27 INFO - 'cart']}, 20:18:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'talos_options': ['--disable-e10s'], 20:18:27 INFO - 'tests': ['tp5o']}, 20:18:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'tests': ['tp5o']}, 20:18:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'talos_options': ['--disable-e10s', 20:18:27 INFO - '--xperf_path', 20:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:27 INFO - 'tests': ['tp5n']}, 20:18:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:27 INFO - 'talos_options': ['--xperf_path', 20:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:27 INFO - 'tests': ['tp5n']}}, 20:18:27 INFO - 'talos.zip': {'path': '', 20:18:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:18:27 INFO - Running post-action listener: _resource_record_post_action 20:18:27 INFO - ##### 20:18:27 INFO - ##### Finished populate-webroot step (success) 20:18:27 INFO - ##### 20:18:27 INFO - ##### 20:18:27 INFO - ##### Running create-virtualenv step. 20:18:27 INFO - ##### 20:18:27 INFO - Running pre-action listener: _resource_record_pre_action 20:18:27 INFO - Running main action method: create_virtualenv 20:18:27 INFO - Creating virtualenv /builds/slave/test/build/venv 20:18:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:18:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:18:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:18:27 INFO - Using real prefix '/usr' 20:18:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:18:27 INFO - Installing distribute.............................................................................................................................................................................................done. 20:18:29 INFO - Installing pip.................done. 20:18:29 INFO - Return code: 0 20:18:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:18:29 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')]} 20:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:29 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')]} 20:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:29 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 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:18:29 INFO - Using env: {'DISPLAY': ':0', 20:18:29 INFO - 'HOME': '/home/cltbld', 20:18:29 INFO - 'LANG': 'en_US.UTF-8', 20:18:29 INFO - 'LANGUAGE': 'en_US:en', 20:18:29 INFO - 'LOGNAME': 'cltbld', 20:18:29 INFO - 'MAIL': '/var/mail/cltbld', 20:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:29 INFO - 'MOZ_NO_REMOTE': '1', 20:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:29 INFO - 'NO_EM_RESTART': '1', 20:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:29 INFO - 'PWD': '/builds/slave/test', 20:18:29 INFO - 'SHELL': '/bin/bash', 20:18:29 INFO - 'SHLVL': '1', 20:18:29 INFO - 'TERM': 'linux', 20:18:29 INFO - 'TMOUT': '86400', 20:18:29 INFO - 'USER': 'cltbld', 20:18:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:29 INFO - '_': '/tools/buildbot/bin/python'} 20:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:18:30 INFO - Cleaning up... 20:18:30 INFO - Return code: 0 20:18:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:30 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 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:18:30 INFO - Using env: {'DISPLAY': ':0', 20:18:30 INFO - 'HOME': '/home/cltbld', 20:18:30 INFO - 'LANG': 'en_US.UTF-8', 20:18:30 INFO - 'LANGUAGE': 'en_US:en', 20:18:30 INFO - 'LOGNAME': 'cltbld', 20:18:30 INFO - 'MAIL': '/var/mail/cltbld', 20:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:30 INFO - 'MOZ_NO_REMOTE': '1', 20:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:30 INFO - 'NO_EM_RESTART': '1', 20:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:30 INFO - 'PWD': '/builds/slave/test', 20:18:30 INFO - 'SHELL': '/bin/bash', 20:18:30 INFO - 'SHLVL': '1', 20:18:30 INFO - 'TERM': 'linux', 20:18:30 INFO - 'TMOUT': '86400', 20:18:30 INFO - 'USER': 'cltbld', 20:18:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:30 INFO - '_': '/tools/buildbot/bin/python'} 20:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:30 INFO - Downloading/unpacking psutil>=3.1.1 20:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:18:32 INFO - Installing collected packages: psutil 20:18:32 INFO - Running setup.py install for psutil 20:18:32 INFO - building 'psutil._psutil_linux' extension 20:18:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:18:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:18:32 INFO - building 'psutil._psutil_posix' extension 20:18:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:18:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:18:32 INFO - Successfully installed psutil 20:18:32 INFO - Cleaning up... 20:18:32 INFO - Return code: 0 20:18:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:18:32 INFO - Using env: {'DISPLAY': ':0', 20:18:32 INFO - 'HOME': '/home/cltbld', 20:18:32 INFO - 'LANG': 'en_US.UTF-8', 20:18:32 INFO - 'LANGUAGE': 'en_US:en', 20:18:32 INFO - 'LOGNAME': 'cltbld', 20:18:32 INFO - 'MAIL': '/var/mail/cltbld', 20:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:32 INFO - 'MOZ_NO_REMOTE': '1', 20:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:32 INFO - 'NO_EM_RESTART': '1', 20:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:32 INFO - 'PWD': '/builds/slave/test', 20:18:32 INFO - 'SHELL': '/bin/bash', 20:18:32 INFO - 'SHLVL': '1', 20:18:32 INFO - 'TERM': 'linux', 20:18:32 INFO - 'TMOUT': '86400', 20:18:32 INFO - 'USER': 'cltbld', 20:18:32 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:32 INFO - '_': '/tools/buildbot/bin/python'} 20:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:18:35 INFO - Installing collected packages: mozsystemmonitor 20:18:35 INFO - Running setup.py install for mozsystemmonitor 20:18:35 INFO - Successfully installed mozsystemmonitor 20:18:35 INFO - Cleaning up... 20:18:35 INFO - Return code: 0 20:18:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:35 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 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:18:35 INFO - Using env: {'DISPLAY': ':0', 20:18:35 INFO - 'HOME': '/home/cltbld', 20:18:35 INFO - 'LANG': 'en_US.UTF-8', 20:18:35 INFO - 'LANGUAGE': 'en_US:en', 20:18:35 INFO - 'LOGNAME': 'cltbld', 20:18:35 INFO - 'MAIL': '/var/mail/cltbld', 20:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:35 INFO - 'MOZ_NO_REMOTE': '1', 20:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:35 INFO - 'NO_EM_RESTART': '1', 20:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:35 INFO - 'PWD': '/builds/slave/test', 20:18:35 INFO - 'SHELL': '/bin/bash', 20:18:35 INFO - 'SHLVL': '1', 20:18:35 INFO - 'TERM': 'linux', 20:18:35 INFO - 'TMOUT': '86400', 20:18:35 INFO - 'USER': 'cltbld', 20:18:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:35 INFO - '_': '/tools/buildbot/bin/python'} 20:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:36 INFO - Downloading/unpacking jsonschema==2.5.1 20:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:18:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 20:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:18:38 INFO - warning: no files found matching '*.txt' 20:18:38 INFO - no previously-included directories found matching 'build' 20:18:38 INFO - no previously-included directories found matching 'dist' 20:18:38 INFO - no previously-included directories found matching '.git*' 20:18:38 INFO - Installing collected packages: jsonschema, functools32 20:18:38 INFO - Running setup.py install for functools32 20:18:38 INFO - warning: no files found matching '*.txt' 20:18:38 INFO - no previously-included directories found matching 'build' 20:18:38 INFO - no previously-included directories found matching 'dist' 20:18:38 INFO - no previously-included directories found matching '.git*' 20:18:38 INFO - Successfully installed jsonschema functools32 20:18:38 INFO - Cleaning up... 20:18:38 INFO - Return code: 0 20:18:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:18:38 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')]} 20:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:38 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')]} 20:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:38 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 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:18:38 INFO - Using env: {'DISPLAY': ':0', 20:18:38 INFO - 'HOME': '/home/cltbld', 20:18:38 INFO - 'LANG': 'en_US.UTF-8', 20:18:38 INFO - 'LANGUAGE': 'en_US:en', 20:18:38 INFO - 'LOGNAME': 'cltbld', 20:18:38 INFO - 'MAIL': '/var/mail/cltbld', 20:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:38 INFO - 'MOZ_NO_REMOTE': '1', 20:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:38 INFO - 'NO_EM_RESTART': '1', 20:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:38 INFO - 'PWD': '/builds/slave/test', 20:18:38 INFO - 'SHELL': '/bin/bash', 20:18:38 INFO - 'SHLVL': '1', 20:18:38 INFO - 'TERM': 'linux', 20:18:38 INFO - 'TMOUT': '86400', 20:18:38 INFO - 'USER': 'cltbld', 20:18:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:38 INFO - '_': '/tools/buildbot/bin/python'} 20:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:40 INFO - Downloading blobuploader-1.2.4.tar.gz 20:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:18:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:18:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:41 INFO - Downloading docopt-0.6.1.tar.gz 20:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:18:41 INFO - Installing collected packages: blobuploader, requests, docopt 20:18:41 INFO - Running setup.py install for blobuploader 20:18:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:18:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:18:41 INFO - Running setup.py install for requests 20:18:41 INFO - Running setup.py install for docopt 20:18:42 INFO - Successfully installed blobuploader requests docopt 20:18:42 INFO - Cleaning up... 20:18:42 INFO - Return code: 0 20:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:42 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 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:18:42 INFO - Using env: {'DISPLAY': ':0', 20:18:42 INFO - 'HOME': '/home/cltbld', 20:18:42 INFO - 'LANG': 'en_US.UTF-8', 20:18:42 INFO - 'LANGUAGE': 'en_US:en', 20:18:42 INFO - 'LOGNAME': 'cltbld', 20:18:42 INFO - 'MAIL': '/var/mail/cltbld', 20:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:42 INFO - 'MOZ_NO_REMOTE': '1', 20:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:42 INFO - 'NO_EM_RESTART': '1', 20:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:42 INFO - 'PWD': '/builds/slave/test', 20:18:42 INFO - 'SHELL': '/bin/bash', 20:18:42 INFO - 'SHLVL': '1', 20:18:42 INFO - 'TERM': 'linux', 20:18:42 INFO - 'TMOUT': '86400', 20:18:42 INFO - 'USER': 'cltbld', 20:18:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:42 INFO - '_': '/tools/buildbot/bin/python'} 20:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:18:42 INFO - Running setup.py (path:/tmp/pip-tJhdk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:18:42 INFO - Running setup.py (path:/tmp/pip-norbym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:18:42 INFO - Running setup.py (path:/tmp/pip-zez1ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:18:42 INFO - Running setup.py (path:/tmp/pip-CLE10v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:18:42 INFO - Running setup.py (path:/tmp/pip-luzTOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:18:42 INFO - Running setup.py (path:/tmp/pip-B7pAIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:18:42 INFO - Running setup.py (path:/tmp/pip-5hl4PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:18:42 INFO - Running setup.py (path:/tmp/pip-QYO79v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:18:42 INFO - Running setup.py (path:/tmp/pip-LkfOHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:18:42 INFO - Running setup.py (path:/tmp/pip-3xNF7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:18:43 INFO - Running setup.py (path:/tmp/pip-7gA07H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:18:43 INFO - Running setup.py (path:/tmp/pip-_pO_Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:18:43 INFO - Running setup.py (path:/tmp/pip-MyXjbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:18:43 INFO - Running setup.py (path:/tmp/pip-yAAN4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:43 INFO - Running setup.py (path:/tmp/pip-RquPa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:18:43 INFO - Running setup.py (path:/tmp/pip-0i7rDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:18:43 INFO - Running setup.py (path:/tmp/pip-m6Wp0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:18:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:18:43 INFO - Running setup.py install for manifestparser 20:18:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:18:43 INFO - Running setup.py install for mozcrash 20:18:43 INFO - Running setup.py install for mozdebug 20:18:43 INFO - Running setup.py install for mozdevice 20:18:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:18:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:18:43 INFO - Running setup.py install for mozfile 20:18:44 INFO - Running setup.py install for mozhttpd 20:18:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Running setup.py install for mozinfo 20:18:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Running setup.py install for mozInstall 20:18:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Running setup.py install for mozleak 20:18:44 INFO - Running setup.py install for mozlog 20:18:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Running setup.py install for moznetwork 20:18:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Running setup.py install for mozprocess 20:18:44 INFO - Running setup.py install for mozprofile 20:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:18:44 INFO - Running setup.py install for mozrunner 20:18:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:18:45 INFO - Running setup.py install for mozscreenshot 20:18:45 INFO - Running setup.py install for moztest 20:18:45 INFO - Running setup.py install for mozversion 20:18:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:18:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:18:45 INFO - Cleaning up... 20:18:45 INFO - Return code: 0 20:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:45 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 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:18:45 INFO - Using env: {'DISPLAY': ':0', 20:18:45 INFO - 'HOME': '/home/cltbld', 20:18:45 INFO - 'LANG': 'en_US.UTF-8', 20:18:45 INFO - 'LANGUAGE': 'en_US:en', 20:18:45 INFO - 'LOGNAME': 'cltbld', 20:18:45 INFO - 'MAIL': '/var/mail/cltbld', 20:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:45 INFO - 'MOZ_NO_REMOTE': '1', 20:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:45 INFO - 'NO_EM_RESTART': '1', 20:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:45 INFO - 'PWD': '/builds/slave/test', 20:18:45 INFO - 'SHELL': '/bin/bash', 20:18:45 INFO - 'SHLVL': '1', 20:18:45 INFO - 'TERM': 'linux', 20:18:45 INFO - 'TMOUT': '86400', 20:18:45 INFO - 'USER': 'cltbld', 20:18:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:45 INFO - '_': '/tools/buildbot/bin/python'} 20:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:18:45 INFO - Running setup.py (path:/tmp/pip-2lv9wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:18:45 INFO - Running setup.py (path:/tmp/pip-hOeaci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:18:45 INFO - Running setup.py (path:/tmp/pip-dXQYDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:18:45 INFO - Running setup.py (path:/tmp/pip-AKcJdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:18:45 INFO - Running setup.py (path:/tmp/pip-9iKTD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:18:45 INFO - Running setup.py (path:/tmp/pip-LluVqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:18:45 INFO - Running setup.py (path:/tmp/pip-H1fOXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:18:46 INFO - Running setup.py (path:/tmp/pip-n3ekGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:18:46 INFO - Running setup.py (path:/tmp/pip-OGxkwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:18:46 INFO - Running setup.py (path:/tmp/pip-fkdwjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:18:46 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)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:18:46 INFO - Running setup.py (path:/tmp/pip-QmV5xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:18:46 INFO - Running setup.py (path:/tmp/pip-rCrWtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:18:46 INFO - Running setup.py (path:/tmp/pip-OMO9rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:18:46 INFO - Running setup.py (path:/tmp/pip-2t_JBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:46 INFO - Running setup.py (path:/tmp/pip-xh_esI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:18:46 INFO - Running setup.py (path:/tmp/pip-pW_M6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:18:46 INFO - Running setup.py (path:/tmp/pip-_sbjlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:18:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:48 INFO - Downloading blessings-1.6.tar.gz 20:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:18:48 INFO - Installing collected packages: blessings 20:18:48 INFO - Running setup.py install for blessings 20:18:48 INFO - Successfully installed blessings 20:18:48 INFO - Cleaning up... 20:18:48 INFO - Return code: 0 20:18:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:49 INFO - Reading from file tmpfile_stdout 20:18:49 INFO - Current package versions: 20:18:49 INFO - argparse == 1.2.1 20:18:49 INFO - blessings == 1.6 20:18:49 INFO - blobuploader == 1.2.4 20:18:49 INFO - docopt == 0.6.1 20:18:49 INFO - functools32 == 3.2.3-2 20:18:49 INFO - jsonschema == 2.5.1 20:18:49 INFO - manifestparser == 1.1 20:18:49 INFO - mozInstall == 1.12 20:18:49 INFO - mozcrash == 0.17 20:18:49 INFO - mozdebug == 0.1 20:18:49 INFO - mozdevice == 0.48 20:18:49 INFO - mozfile == 1.2 20:18:49 INFO - mozhttpd == 0.7 20:18:49 INFO - mozinfo == 0.9 20:18:49 INFO - mozleak == 0.1 20:18:49 INFO - mozlog == 3.2 20:18:49 INFO - moznetwork == 0.27 20:18:49 INFO - mozprocess == 0.23 20:18:49 INFO - mozprofile == 0.28 20:18:49 INFO - mozrunner == 6.12 20:18:49 INFO - mozscreenshot == 0.1 20:18:49 INFO - mozsystemmonitor == 0.3 20:18:49 INFO - moztest == 0.7 20:18:49 INFO - mozversion == 1.4 20:18:49 INFO - psutil == 3.1.1 20:18:49 INFO - requests == 1.2.3 20:18:49 INFO - wsgiref == 0.1.2 20:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:49 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 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:18:49 INFO - Using env: {'DISPLAY': ':0', 20:18:49 INFO - 'HOME': '/home/cltbld', 20:18:49 INFO - 'LANG': 'en_US.UTF-8', 20:18:49 INFO - 'LANGUAGE': 'en_US:en', 20:18:49 INFO - 'LOGNAME': 'cltbld', 20:18:49 INFO - 'MAIL': '/var/mail/cltbld', 20:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:49 INFO - 'MOZ_NO_REMOTE': '1', 20:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:49 INFO - 'NO_EM_RESTART': '1', 20:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:49 INFO - 'PWD': '/builds/slave/test', 20:18:49 INFO - 'SHELL': '/bin/bash', 20:18:49 INFO - 'SHLVL': '1', 20:18:49 INFO - 'TERM': 'linux', 20:18:49 INFO - 'TMOUT': '86400', 20:18:49 INFO - 'USER': 'cltbld', 20:18:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:49 INFO - '_': '/tools/buildbot/bin/python'} 20:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:18:49 INFO - Cleaning up... 20:18:49 INFO - Return code: 0 20:18:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:18:49 INFO - Using env: {'DISPLAY': ':0', 20:18:49 INFO - 'HOME': '/home/cltbld', 20:18:49 INFO - 'LANG': 'en_US.UTF-8', 20:18:49 INFO - 'LANGUAGE': 'en_US:en', 20:18:49 INFO - 'LOGNAME': 'cltbld', 20:18:49 INFO - 'MAIL': '/var/mail/cltbld', 20:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:49 INFO - 'MOZ_NO_REMOTE': '1', 20:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:49 INFO - 'NO_EM_RESTART': '1', 20:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:49 INFO - 'PWD': '/builds/slave/test', 20:18:49 INFO - 'SHELL': '/bin/bash', 20:18:49 INFO - 'SHLVL': '1', 20:18:49 INFO - 'TERM': 'linux', 20:18:49 INFO - 'TMOUT': '86400', 20:18:49 INFO - 'USER': 'cltbld', 20:18:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:49 INFO - '_': '/tools/buildbot/bin/python'} 20:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:18:49 INFO - Cleaning up... 20:18:49 INFO - Return code: 0 20:18:49 INFO - Running post-action listener: _resource_record_post_action 20:18:49 INFO - Running post-action listener: _start_resource_monitoring 20:18:49 INFO - Starting resource monitoring. 20:18:49 INFO - ##### 20:18:49 INFO - ##### Finished create-virtualenv step (success) 20:18:49 INFO - ##### 20:18:49 INFO - ##### 20:18:49 INFO - ##### Running install step. 20:18:49 INFO - ##### 20:18:49 INFO - Running pre-action listener: _resource_record_pre_action 20:18:49 INFO - Running main action method: install 20:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:49 INFO - Reading from file tmpfile_stdout 20:18:49 INFO - Detecting whether we're running mozinstall >=1.0... 20:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:18:49 INFO - Reading from file tmpfile_stdout 20:18:49 INFO - Output received: 20:18:49 INFO - Usage: mozinstall [options] installer 20:18:49 INFO - Options: 20:18:49 INFO - -h, --help show this help message and exit 20:18:49 INFO - -d DEST, --destination=DEST 20:18:49 INFO - Directory to install application into. [default: 20:18:49 INFO - "/builds/slave/test"] 20:18:49 INFO - --app=APP Application being installed. [default: firefox] 20:18:49 INFO - mkdir: /builds/slave/test/build/application 20:18:49 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'] 20:18:49 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 20:19:07 INFO - Reading from file tmpfile_stdout 20:19:07 INFO - Output received: 20:19:07 INFO - /builds/slave/test/build/application/firefox/firefox 20:19:07 INFO - Running post-action listener: _resource_record_post_action 20:19:07 INFO - ##### 20:19:07 INFO - ##### Finished install step (success) 20:19:07 INFO - ##### 20:19:07 INFO - ##### 20:19:07 INFO - ##### Running run-tests step. 20:19:07 INFO - ##### 20:19:07 INFO - Running pre-action listener: _resource_record_pre_action 20:19:07 INFO - Running main action method: run_tests 20:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:19:07 INFO - Python 2.7.3 20:19:07 INFO - Return code: 0 20:19:07 INFO - grabbing minidump binary from tooltool 20:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:19:07 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 0x16823b0>, '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 0x16832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1683740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:19:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:19:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:19:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:19:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:19:07 INFO - Return code: 0 20:19:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:19:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:19:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:19:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:19:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 20:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 20:19:07 INFO - Using env: {'DISPLAY': ':0', 20:19:07 INFO - 'HOME': '/home/cltbld', 20:19:07 INFO - 'LANG': 'en_US.UTF-8', 20:19:07 INFO - 'LANGUAGE': 'en_US:en', 20:19:07 INFO - 'LOGNAME': 'cltbld', 20:19:07 INFO - 'MAIL': '/var/mail/cltbld', 20:19:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:19:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:07 INFO - 'MOZ_NO_REMOTE': '1', 20:19:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:07 INFO - 'NO_EM_RESTART': '1', 20:19:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:07 INFO - 'PWD': '/builds/slave/test', 20:19:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:19:07 INFO - 'SHELL': '/bin/bash', 20:19:07 INFO - 'SHLVL': '1', 20:19:07 INFO - 'TERM': 'linux', 20:19:07 INFO - 'TMOUT': '86400', 20:19:07 INFO - 'USER': 'cltbld', 20:19:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698', 20:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:07 INFO - '_': '/tools/buildbot/bin/python'} 20:19:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 20:19:07 INFO - mozversion application_buildid: 20160712173003 20:19:07 INFO - mozversion application_changeset: 0d7a788f1c40adf5038505e25e600d8551dbda06 20:19:07 INFO - mozversion application_display_name: Nightly 20:19:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:19:07 INFO - mozversion application_name: Firefox 20:19:07 INFO - mozversion application_remotingname: firefox 20:19:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:19:07 INFO - mozversion application_vendor: Mozilla 20:19:07 INFO - mozversion application_version: 50.0a1 20:19:07 INFO - mozversion platform_buildid: 20160712173003 20:19:07 INFO - mozversion platform_changeset: 0d7a788f1c40adf5038505e25e600d8551dbda06 20:19:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:19:07 INFO - mozversion platform_version: 50.0a1 20:19:07 INFO - using testdate: 1468379947 20:19:07 INFO - actual date: 1468379947 20:19:07 INFO - starting webserver on 'localhost:56553' 20:19:07 INFO - SUITE-START | Running 2 tests 20:19:07 INFO - TEST-START | dromaeo_css 20:19:07 INFO - operating with platform_type : linux_ 20:19:07 INFO - Initialising browser for dromaeo_css test... 20:19:07 INFO - TEST-INFO | started process 5730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxJGRQ/profile http://localhost:56553/getInfo.html) 20:19:12 INFO - PROCESS | 5730 | __metrics Screen width/height:1600/1200 20:19:12 INFO - PROCESS | 5730 | colorDepth:24 20:19:12 INFO - PROCESS | 5730 | Browser inner width/height: 1024/697 20:19:12 INFO - PROCESS | 5730 | __metrics 20:19:12 ERROR - PROCESS | 5730 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 20:19:13 INFO - TEST-INFO | 5730: exit 0 20:19:13 INFO - Browser initialized. 20:19:13 INFO - Running cycle 1/1 for dromaeo_css test... 20:19:13 INFO - TEST-INFO | started process 5852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUxJGRQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:25 INFO - PROCESS | 5852 | RSS: Main: 167526400 20:19:25 INFO - PROCESS | 5852 | 20:20:15 INFO - PROCESS | 5852 | 1468380015050 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:22:22 INFO - PROCESS | 5852 | Cycle 1(1): loaded http://localhost:56553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56553/tests/dromaeo/cssquery-ext.html) 20:22:23 INFO - PROCESS | 5852 | RSS: Main: 170213376 20:22:23 INFO - PROCESS | 5852 | 20:25:25 INFO - PROCESS | 5852 | Cycle 1(1): loaded http://localhost:56553/tests/dromaeo/cssquery-ext.html (next: http://localhost:56553/tests/dromaeo/cssquery-jquery.html) 20:25:26 INFO - PROCESS | 5852 | RSS: Main: 167825408 20:25:26 INFO - PROCESS | 5852 | 20:28:28 INFO - PROCESS | 5852 | Cycle 1(1): loaded http://localhost:56553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56553/tests/dromaeo/cssquery-mootools.html) 20:28:28 INFO - PROCESS | 5852 | RSS: Main: 170602496 20:28:28 INFO - PROCESS | 5852 | 20:31:30 INFO - PROCESS | 5852 | Cycle 1(1): loaded http://localhost:56553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56553/tests/dromaeo/cssquery-prototype.html) 20:31:31 INFO - PROCESS | 5852 | RSS: Main: 166408192 20:31:31 INFO - PROCESS | 5852 | 20:34:33 INFO - PROCESS | 5852 | Cycle 1(1): loaded http://localhost:56553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56553/tests/dromaeo/cssquery-yui.html) 20:34:34 INFO - PROCESS | 5852 | RSS: Main: 168288256 20:34:34 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | Cycle 1(1): loaded http://localhost:56553/tests/dromaeo/cssquery-yui.html (next: http://localhost:56553/tests/dromaeo/cssquery-dojo.html) 20:37:36 INFO - PROCESS | 5852 | RSS: Main: 170024960 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | __start_tp_report 20:37:36 INFO - PROCESS | 5852 | _x_x_mozilla_page_load 20:37:36 INFO - PROCESS | 5852 | _x_x_mozilla_page_load_details 20:37:36 INFO - PROCESS | 5852 | |i|pagename|runs| 20:37:36 INFO - PROCESS | 5852 | |0;dojo.html;3123.500239961606;3145.6067991501063;3152.196189971557;3154.637216720078;3168.002079345006;5495.230667706519;5590.909772594346;5600.663960162393;5621.915671264929;5630.268065151535;5407.432219616942;5459.645123066998;5501.972490137554;5537.529310008654;5572.498475137237;4989.101961646902;5010.72441015744;5117.104506711329;5162.251473536335;5211.739413029352;81.88221351325878;5023.271625614284;5111.182210846266;5131.692098474085;5152.92270615941;5020.121478741242;5023.6985780853265;5033.974830125862;5038.949610503884;5082.872928176806;4947.554720075174;5023.32185155003;5049.040682270357;5054.1407960646775;5067.695938243681;4920.3357546731095;4988.925166122511;4991;5005.924911126336;5059.974700126476;5464.535514481274;5479;5503.862403439946;5520.089185284423;5571.498565129158;5773.2494775679315;5841.707914604252;5864.76540938362;5906.852328691817;5913.497352725023;5918.053111502182;5951.3751056139345;5961.195238642815;5984.132300816357;5989.730462129215;5538.086215774432;5543.1408131739245;5546.168074788774;5554.222408862722;5560.193771903092;5959.702014899238;6048.183495228176;6060.636361818305;6075.27096748393;6118.694065296718;5877.764889404461;5883.441073098049;5889.146073819358;5892.970535147297;5895.35151133375;5969.552283578662;5970.164177015221;5984.222051133324;5995.340512543617;5997.580169388189;5749.482546570745;5835.679037652885;5863.765449382062;5903.763849445974;5912.526997840162;5692.060809966392;5816.360200377955;5887.676177810176;5895.793647222326;5896.1450589664255;4513.751743654065;4534.161180181677;4537.636989040869;4538.387317712132;4582.862514124582;3971.3447281198855;3984.2230765000545;4007.218592374459;4037;4048.1701251243426;5747.655140691572;5749.35786392685;5749.626274292157;5752.108423194411;5752.539796816244;5764.682942438206;5966.701664916737;6040.033594624839;6040.848978775566;6041.305249896318;5642.943570564242;5654.236678048411;5663.292088488939;5664.716764161775;5709.885802283931;5126.15418455958;5141.614378921521;5143.819966301162;5147.871303217449;5192.117340052125;6045.33501314855;6098.939010609926;6165.383461653889;6168.1056246844855;6173.444390004921;5927.585069045212;6000.8499787503915;6003.189569408249;6016.067509536029;6054.061620448838;6180.938190618216;6186.257649082139;6193.783217587363;6197.5351848610635;6201.96899015502;5741.081426971665;5777.422257774357;5810.564207684356;5913.940860591339;5920.703964801829;5898.8230353089475;5973.761049557969;5993.760249589967;6015.0676645120075;6066.696665166635;5730.426957304237;5784;5793.565482588739;5823.213866128019;5844.795432160024;5604.85987850307;5704.771809127755;5742.741576629145;5801.361850196559;5805.622634528742;5657.038303488334;5697.173909783141;5705.429457054427;5796.681182535001;5803.9419605803405;5744.684042377709;5779.2775903012125;5827.970860145672;5843.065109582446;5864;5682.176084467646;5740.024195886625;5744.540436764965;5747.885042299215;5772.509336706259 20:37:36 INFO - PROCESS | 5852 | |1;ext.html;557.3470281460251;594.2868557730724;598.6856900127435;614.2383444528784;634.235745926159;39246.60753392465;42632.14735705284;43019;43263;43275.350869736976;43106.137877242436;43753.78123109388;43872.3419148713;43932.78033609827;43936.780316098375;8917.464952102879;9040.457572545669;9041.773955651128;9053.230475409599;9069.863952040725;8797.384183107186;8885;8924.687635932743;8940.64237430502;8956.731298061068;8944.418612790148;8951.194392504673;8952.373333866632;9011.459312441242;9020.23328017116;8867.77830554238;8927.241184499293;8972.551372431351;8975.775605609846;8979.775505612346;8841.469511829311;8935;8969.237614802749;8987.46075235488;8993.325500587482;41636.58363416357;41730.582694172976;41792.79103604493;41905.79047104775;42227.36658950118;3667.9266414671824;3686.096906257984;3687.907802304937;3776.4712940188397;4088.366303223005;33489.16277093068;33668.32663346744;33754.6624533754;34163.487547686804;34766.652333476595;4425.181341451842;4493.326001099861;4506.828224661579;4572.634189264851;4575.382323386333;241031;242019;242181;242242;242891;52491.21263181055;60979.39020609737;63152;64760.35239647637;65366.67316663386;64049.67975160188;64335;64341;64359;64506.677466613306;17534.298628054734;17673.823261767477;17685.115744212737;17697.911510442624;17724.20241089154;13488.93255533716;13508;13516.189028658311;13597.252151131584;13602.251876146907;18245.178966946518;18319.450416487525;18492.763766340835;18523.72214416785;18554.257829686932;5782.421757824184;5817.7091145442555;5959.791407300723;5988.9101663475085;6019.578629495981;956.789506308611;989.678354534779;1009.5608410341379;1033.617561502249;1121.315997241682;31816.20459488485;31944.84027579894;32048.83975580154;32499.18752031218;32591;1063.9042486176281;1097.6706987903597;1185.9703507412385;1200.4477940147456;1225.1607648760628;17016;17031;17186.91406542959;17464.65070698579;17517.516026357254;511860;513252;514084;516933;517045;59222.11166832501;59282.40717592855;59478.40521594815;59631.70184149052;59702.10446843301;1269.650846017334;1313.3958379145508;1334.7063645997864;1350.2641060621984;1360.2586590308306;31356.372872542877;31605.20986975344;31673.683263167073;31998.52002219922;32488;50551.241731374794;50906;51025;51067;51074.74462627663;438956;439421;441481;442899;443302;28413.147605571867;28516.857415713617;28847.85576072106;28852.855735721187;28896.566551501324;50676.74661626668;50744.49255507398;50934.235986460975;51041.74479127729;51494.742526287126;43395;43448.78275608602;44285.55714442943;44289.77855110704;44800.77599612111;41893.371599426646;42143.36784948167;42815.571844281156;43201.91995200145;44428.333574995755;41994.58005419907;42647.57352426436;43238.351424729284;43642;45888.31167532423;36691.08272293214;37724.62275377211;38434.80782596069;38554.421683674205;38901;29237.122886313446;29386.706132939253;29412.11763647094;29723;29930.700692992792 20:37:36 INFO - PROCESS | 5852 | |2;jquery.html;383.31777339794405;385.59705108161967;390.4982098004065;393.66145115200925;409.78281510799286;14340.498082567112;18743.3439829606;19708.70436943447;20567.485812854666;20742.170313187475;18923.43229703111;19314.806851931477;19576.412707618758;19606.62753607248;19636.527260455452;5731.828045158631;5820.738066786994;5903.911441328383;5949.286085669725;5969.552283578727;5224.346956630421;5548.167774833767;5856.033754430535;5877.764889404419;5915.911261331062;5591.189277554752;5598.048331783607;5601.747921343549;5618.325800903876;5626.381098079208;5531.778728850841;5595.552355811526;5614.943850561483;5625.662460252398;5650.463205995424;5402.864928376783;5435.10320797068;5478.534324582415;5502.779888804443;5506.724663766836;20399.184032638826;22555.436114097116;23085.884570577207;23531.647025294635;23572.88213558921;2285.6571514272828;2293.736220334666;2374.8931298091456;2410.927672169838;2475.4306509502735;9571.569279382375;9725.56234969421;9836.803263934753;9916.95041524795;10320;1962.1072412052624;2032.6036422897541;2039.4595432210476;2048.95902081959;2049.7950204979534;84590.57704711499;86812;87730;88098.55950720205;88695;10476;10639.414832184304;10738.94630526858;10864.891351086546;10941.4529273536;14654.633634159018;14761.409543618134;14823.110613363233;14903.403863845542;14909.179995100374;7985.760427187078;8168.142345053802;8196.30331421824;8209.507429554245;8386.287165590871;7993.400494962901;8162.451725426685;8167.591620418955;8181.754547363588;8434.493930364199;4505.324201369821;4508.458984921765;4541.863744087683;4557.863264102082;4593.908121837545;1854.5827188882392;1875.7936626971023;1911.3405874973112;1937.6996565532365;1971.654960381956;982.3074732313702;989.0307498651218;1012.3015119567475;1019.7246743379246;1035.404642330663;19179.80820191808;19222.135003924857;19259.61480770377;19415.2233910642;19782.50543736418;979.7207795778169;1020.5764607687727;1025.195221750922;1026.9383836969805;1047.3768107975743;10299.227557933185;10565.471726413649;10571.36571805694;10743.623973160902;10818.459077046116;499951;503862;508715;510612;510715;94132.0586794137;95985;96941.03058969461;100193.49903250438;101855;966.9661561845443;987.2496902354262;1003.0821798054844;1005.7435353984833;1007.773251018515;17053.403130890358;17085.829141708426;17315.91342043332;17320.874143180652;17531.649367012844;42971.57028429801;43230.13539729125;43723.34414983841;44696.32955505605;44775.552244478444;62815.371846280956;63314;63692.363076368645;64712.352876470635;65011.67494162688;7243.130824300907;7564.130125035691;7987.560684162427;8026.317762990211;8083.797905052421;11940.940295298467;14244.216568088854;14464.927675361556;14484.782728259295;14603.415863365346;12021.338826364634;12165.756684866075;12285.508579656713;12513.93743031279;12530.49878004906;12423.31671758062;12430.12989090755;12471.875281247434;12502.812457813323;12683.11218214716;11266.211365204357;12204.145709800583;12209.755804883675;12504.124711270124;12616.87383126157;8698.434601750865;8706.91293087061;8761.167689069529;8788.121187881416;8948.373613846969;8685.826283474169;11374.829377559177;11937;12400.875991239973;12518.12373133872 20:37:36 INFO - PROCESS | 5852 | |3;mootools.html;1475.52783109405;1506.0436622744555;1622.5294664547282;1760.6918789211884;1766.849817765489;7724.150343462229;8741.388102832805;8852.645894164241;9209.953950230249;9263.39787913786;8800.647974081028;9105.135012173832;9136.771580710485;9166.175044246016;9175.54122293886;2340.4733934864603;2375.714914210297;2376.275236053003;2377.3699969508093;2378.7859092681656;2343.6836027136287;2355.611324131516;2370.8577485350934;2379.393254720044;2381.404648837791;2320.466292752668;2329.487512747193;2335.3577766114367;2354.6114891043044;2366.171839856054;2253.5718213539376;2254.8534345267585;2262.2195342606856;2263.0834512022657;2279.2706333973133;2220.4004918671867;2224.4994876152896;2229.6209644360497;2229.8104661103825;2240.6863039174527;9193.126652967958;9276.350655454122;9314.72055838326;9335.393199442015;9342.532873356373;5253.3170687810725;5375.059364611217;5399;5410.756515956791;5411.134218525017;3365.4615261558033;3409.7613167078316;3496.283261931298;3511.2977404519197;3521.559805024372;1106.7399161197113;1126.1610100475116;1142.731458107344;1163.162522983459;1166;12708.173968692005;12744.10791244604;12745.426455809511;12777.29724865132;12841.614751557374;4430.667699922518;4549.385832912581;4621.907561848744;4728.905421891543;4735.384400027974;10698.572057117784;10757.515911783988;10766.354018758899;10774.084202842689;10778.78442431147;5357.705326207096;5377.650452720561;5378.515933565998;5379.031774280589;5386.299781028441;4381.6494680425485;4810.278458231293;4943.456219815817;4991.750412479434;4995.850124496271;3963.8810835674976;4002.5597184309704;4041.211963667057;4069.5320038195396;4109.465769450012;1236.313845815563;1253.5361916091106;1261.9053570982212;1266.9873301266869;1271.2690203133236;824.8309096635176;931.2736065868634;988.7528117970508;995.9601615935281;1013.4932533733133;5833.7374818133285;5957.851053723692;5995.730192141277;6069.180660610849;6187.535934804908;434.6457637025877;434.7521912509839;440.8677396781017;441.7018512504111;463.84693051292993;3988.840446382112;4124.4019617155345;4143.585641435892;4160.45914031174;4164.000639846476;10907.291026083438;11096.278741881752;11236.101111911028;11316.321020738782;11380.658580242605;11263.66209013731;11300.71748206285;11329.603463878724;11358.659240222807;11365.545378184945;8392.538410387488;8497.872531912026;8559.914400856036;8663.826723465621;8711.651533938699;5881.852953676193;5922.170896074467;6031.36670649593;6065.272167339947;6101.6644084574;10421.270511064457;10489;10541.051305382553;10566.943305669372;10618.415987120783;10518.263721539419;10635;10662.946685266834;10783.460826958777;10815.080718138732;7371.668274927534;7810.9218907812465;8071.515709057476;8127.715529956423;8210.753677389688;8916.55417229149;8950.060243674321;8973.955130224307;9000.369974102012;9011.459312441275;7609.923900761143;7807.219278072147;7840.843183136191;7929.246721561442;7960.681572737258;7936.206379362017;7959;8067.677292908453;8112.513249205066;8219.178082191733;6548.410643042149;6706.530542861953;6755.459563234831;6801.455883529206;6817.659117044029;5164.612654050886;5200.349956255468;5201.817936372209;5209.895802083861;5248.895022099613;5053.397500287429;5069.3156423883775;5099.260607212008;5131.127708289674;5196 20:37:36 INFO - PROCESS | 5852 | |4;prototype.html;318.83898631191244;320.0941336019066;323.6747069195458;327.8196991654589;329.8598095809281;5557.360903496099;5613.831585052445;5632.239647647566;5638.419603551738;5650.830475085743;5548.278723765905;5557.805476808313;5574.275344205248;5577.358603760569;5612.69130197839;4090.6522945549664;4188.560201178878;4290.399344091829;4301.29028710264;4312.28847240205;4267.1892340455215;4294.441722576061;4299.462567179103;4316.589923957219;4323.762193079379;4253.44705188325;4286.185624731306;4286.728034141895;4291.8712438626735;4307.375430562566;3991.301522233612;4238.4490016298;4239;4247.957520424818;4313.849015284466;3679.8344074516713;3710.4619830124752;3718.72109591779;3720.8511659533588;3721.7160079772434;5421.213923981;5435.858469721364;5444.265024221759;5454.018276710191;5500.22996780451;4641.559051890065;4858.5384388483035;4874.341963834872;4893.95106048942;4921.80312787488;5781.4507621775865;5805.390434004453;5808.796692115756;5821.592488525805;5829.5919285650025;4056.5132184137797;4074.7351422157467;4079.653229475498;4083;4085.0400155963325;5859.4140585941495;6065.756519913407;6070.908936365958;6076.726547305382;6096.664683442409;4157.64660003897;4171.124063946544;4177.060161463646;4184.5187803403;4186.35111557709;4215.768132752667;4218.957810421918;4221.894452638709;4225.070484493406;4280.935785963213;4761.166950723996;4879.756012199447;4884.511548845158;4926.876828079255;4964.35463389757;5861.70691465425;5876.529877609781;5888.381719919433;5910.674912879746;5928.584999050025;1465.7874608181753;1467.8917417350046;1467.992660036693;1477.1211129378003;1479.2677624575688;924.7040946897063;935.864299676543;955.2835373469898;985.7338518599938;993.2451336983944;5641.182028605829;5673.6028478006965;5687.7156142192725;5688.265079150816;5688.606291458619;5908.134554740947;5928.584999050111;5968.641881487125;5977.701114944235;6052.576319657582;5467.398586155519;5725.997950358671;5759.424057594207;5759.971200143972;5787.797427090116;3202.4235637585457;3202.8309666971854;3214.2928555717704;3214.4856822908223;3216.1477208539754;6039.667818270037;6098.963176260047;6189.752409903554;6194.101855230966;6224;6147.200863887666;6164.4143806338325;6167.951448253808;6174.753009879644;6177.69111544421;6079.848003799941;6205.596636218722;6207.317195108534;6219.502439804804;6220.050268079802;5924.851878703067;5981.521478281814;5994.730237139426;6006.3182308953565;6007.429294217042;5927.2590926134235;5930.970345148246;5940.405959404025;5940.851478713067;5980.192673988956;5976.3127240366175;6136.23297087864;6191.4118158774845;6231.937680623136;6257.749690012531;4155.605217504332;4160.292750232407;4175.874723758292;4179.286492538166;4186.748795072305;5778.768849245983;5804.171685918922;6015;6022.90965635507;6035.6076855004285;5875.236219291465;5877.647341159544;5891.764329426775;5913.231279933581;5916.349201587908;5852.736626851717;5855.502282306052;5856.795012174553;5869.911951320819;5889.234399528034;5594.41258667834;5829.09649004405;5875.6474611523445;5876.324222714443;5881.206037185097;5903.586748927705;5933;5938.940610593839;5947.197128387612;5955.880882382415;5649.519790817826;5672.574556908331;5778.595498315078;5787.479126878601;5801.998310582842 20:37:36 INFO - PROCESS | 5852 | |5;yui.html;717.9892301615477;785.9646315915783;789.7946533901188;797.2904115337349;850.2517784349772;15591.220438978049;16566.420175293853;16569.917150414247;16686.66626667466;16691.248893799777;14863.405463781435;14971;14983.700325993474;15000.549983500485;15005.774913376308;628.6699482771547;758.2872100225798;775.9650815713306;781.0744268042359;781.6756046240803;781.3358645151604;784.925432083954;785.8428314337127;787.9290863822255;788.3732432716005;825.3026192867018;826.5701835045803;833.8790875323075;836.6736972580699;837.0374069819726;814.1614137438389;820.3437250199846;822.8724547695117;822.9917700822975;825.0099880143821;602.4066294699717;604.6100265328838;607.8176547035915;607.9300880398722;608.1850320570412;14216.644583885382;14256.501022464268;14258.429662813474;14296.642583935381;14297.070690405195;15569.688606227925;15745.92127039369;15914.920425397915;15987.600309992227;16343.754843677354;12693.048021398432;12772.808407873888;12930.54743083997;13006;13082.672933176651;3838.596947320519;3840.6735427488697;3886.5724770275247;3894.863679771223;3962.5839286874752;72133.63933180353;72364;73116;73908;75797.62101189514;11612.6516204514;11709.941450292694;11731.765364692828;11847.526098955945;11870.406479675981;21804.672929906064;22554.436139096655;22624.98187581563;22663;22697.205597803997;7948.443608947318;8126.471779334324;8272.462289951134;8379.120192379834;8528.53093079874;4897.118518666674;5018.247262910592;5042.42012168598;5048.646594738407;5226.97386513065;3472.409690352646;3603.7567039371374;3614.7831130132276;3615.29501747162;3617.113807117273;582.2692520886261;593.4214141212369;595.3094410483818;602.3885755957706;612.8958077126899;667.7796327212009;673.4141297071579;677.9389854912982;679.7586856665812;690.3338278561213;9375.203107735919;9529.190018848338;9551.42691438516;9631.991364490426;10078.899211007943;596.83885350955;670.5105273150627;692.944564434844;693.6081114170578;710.0662628643317;4598.747068911242;4667.6265898728025;4721.268203428474;4728.3143944127905;4765;68113.3188668107;79938.6003069981;113568.43215784033;115043.42478287555;115944;99266.5036674812;99527.50236248772;100730.4963475178;100918;102489.48755256175;54765.726171368886;62824.68587657032;81525;84447.5777621108;84623.5768821152;9935.65225217114;10045.246606504395;10078.596856125967;10718.35689858611;11050.502727377449;37742.8112859434;51392.229116562536;53832.73083634557;53849.73075134599;54562.454375457324;56802;75477.62261188879;76705.2329476698;78412.60793695995;80049.19950800418;12445;12657.493700251887;13594.728105438033;13849.930750346184;13858.4456621734;15548.533543993699;16283.674326513641;16474.176291185155;17105.657886841946;17139;14669.413223470941;14920;15636.843631563994;15684.451044213398;16253.268602912662;15205.087694738351;15224;15434.382624694887;15476.380944762084;15533.533993980198;12988.090833641554;13682.726345472836;14073.718525629634;14514.419423222953;16065;11999.220050696676;12015.519379225083;12148.635540933432;12187.75624487523;12505.93747031259;10866.67399978002;11166.53609290246;11787.941060294643;11860.525578976743;11861.110416718608 20:37:36 INFO - PROCESS | 5852 | __end_tp_report 20:37:36 INFO - PROCESS | 5852 | __start_cc_report 20:37:36 INFO - PROCESS | 5852 | _x_x_mozilla_cycle_collect,370 20:37:36 INFO - PROCESS | 5852 | __end_cc_report 20:37:36 INFO - PROCESS | 5852 | __startTimestamp1468381056840__endTimestamp 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | ------- Summary: start ------- 20:37:36 INFO - PROCESS | 5852 | Number of tests: 6 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | [#0] dojo.html Cycles:165 Average:5485.64 Median:5747.66 stddev:763.62 (13.3%) stddev-sans-first:743.14 20:37:36 INFO - PROCESS | 5852 | Values: 3123.5 3145.6 3152.2 3154.6 3168.0 5495.2 5590.9 5600.7 5621.9 5630.3 5407.4 5459.6 5502.0 5537.5 5572.5 4989.1 5010.7 5117.1 5162.3 5211.7 81.9 5023.3 5111.2 5131.7 5152.9 5020.1 5023.7 5034.0 5038.9 5082.9 4947.6 5023.3 5049.0 5054.1 5067.7 4920.3 4988.9 4991.0 5005.9 5060.0 5464.5 5479.0 5503.9 5520.1 5571.5 5773.2 5841.7 5864.8 5906.9 5913.5 5918.1 5951.4 5961.2 5984.1 5989.7 5538.1 5543.1 5546.2 5554.2 5560.2 5959.7 6048.2 6060.6 6075.3 6118.7 5877.8 5883.4 5889.1 5893.0 5895.4 5969.6 5970.2 5984.2 5995.3 5997.6 5749.5 5835.7 5863.8 5903.8 5912.5 5692.1 5816.4 5887.7 5895.8 5896.1 4513.8 4534.2 4537.6 4538.4 4582.9 3971.3 3984.2 4007.2 4037.0 4048.2 5747.7 5749.4 5749.6 5752.1 5752.5 5764.7 5966.7 6040.0 6040.8 6041.3 5642.9 5654.2 5663.3 5664.7 5709.9 5126.2 5141.6 5143.8 5147.9 5192.1 6045.3 6098.9 6165.4 6168.1 6173.4 5927.6 6000.8 6003.2 6016.1 6054.1 6180.9 6186.3 6193.8 6197.5 6202.0 5741.1 5777.4 5810.6 5913.9 5920.7 5898.8 5973.8 5993.8 6015.1 6066.7 5730.4 5784.0 5793.6 5823.2 5844.8 5604.9 5704.8 5742.7 5801.4 5805.6 5657.0 5697.2 5705.4 5796.7 5803.9 5744.7 5779.3 5828.0 5843.1 5864.0 5682.2 5740.0 5744.5 5747.9 5772.5 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | [#1] ext.html Cycles:180 Average:57430.54 Median:43335.18 stddev:110246.18 (254.4%) stddev-sans-first:110472.75 20:37:36 INFO - PROCESS | 5852 | Values: 557.3 594.3 598.7 614.2 634.2 39246.6 42632.1 43019.0 43263.0 43275.4 43106.1 43753.8 43872.3 43932.8 43936.8 8917.5 9040.5 9041.8 9053.2 9069.9 8797.4 8885.0 8924.7 8940.6 8956.7 8944.4 8951.2 8952.4 9011.5 9020.2 8867.8 8927.2 8972.6 8975.8 8979.8 8841.5 8935.0 8969.2 8987.5 8993.3 41636.6 41730.6 41792.8 41905.8 42227.4 3667.9 3686.1 3687.9 3776.5 4088.4 33489.2 33668.3 33754.7 34163.5 34766.7 4425.2 4493.3 4506.8 4572.6 4575.4 241031.0 242019.0 242181.0 242242.0 242891.0 52491.2 60979.4 63152.0 64760.4 65366.7 64049.7 64335.0 64341.0 64359.0 64506.7 17534.3 17673.8 17685.1 17697.9 17724.2 13488.9 13508.0 13516.2 13597.3 13602.3 18245.2 18319.5 18492.8 18523.7 18554.3 5782.4 5817.7 5959.8 5988.9 6019.6 956.8 989.7 1009.6 1033.6 1121.3 31816.2 31944.8 32048.8 32499.2 32591.0 1063.9 1097.7 1186.0 1200.4 1225.2 17016.0 17031.0 17186.9 17464.7 17517.5 511860.0 513252.0 514084.0 516933.0 517045.0 59222.1 59282.4 59478.4 59631.7 59702.1 1269.7 1313.4 1334.7 1350.3 1360.3 31356.4 31605.2 31673.7 31998.5 32488.0 50551.2 50906.0 51025.0 51067.0 51074.7 438956.0 439421.0 441481.0 442899.0 443302.0 28413.1 28516.9 28847.9 28852.9 28896.6 50676.7 50744.5 50934.2 51041.7 51494.7 43395.0 43448.8 44285.6 44289.8 44800.8 41893.4 42143.4 42815.6 43201.9 44428.3 41994.6 42647.6 43238.4 43642.0 45888.3 36691.1 37724.6 38434.8 38554.4 38901.0 29237.1 29386.7 29412.1 29723.0 29930.7 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | [#2] jquery.html Cycles:180 Average:30022.47 Median:2443.18 stddev:83782.26 (3429.2%) stddev-sans-first:83987.74 20:37:36 INFO - PROCESS | 5852 | Values: 383.3 385.6 390.5 393.7 409.8 14340.5 18743.3 19708.7 20567.5 20742.2 18923.4 19314.8 19576.4 19606.6 19636.5 5731.8 5820.7 5903.9 5949.3 5969.6 5224.3 5548.2 5856.0 5877.8 5915.9 5591.2 5598.0 5601.7 5618.3 5626.4 5531.8 5595.6 5614.9 5625.7 5650.5 5402.9 5435.1 5478.5 5502.8 5506.7 20399.2 22555.4 23085.9 23531.6 23572.9 2285.7 2293.7 2374.9 2410.9 2475.4 9571.6 9725.6 9836.8 9917.0 10320.0 1962.1 2032.6 2039.5 2049.0 2049.8 84590.6 86812.0 87730.0 88098.6 88695.0 10476.0 10639.4 10738.9 10864.9 10941.5 14654.6 14761.4 14823.1 14903.4 14909.2 7985.8 8168.1 8196.3 8209.5 8386.3 7993.4 8162.5 8167.6 8181.8 8434.5 4505.3 4508.5 4541.9 4557.9 4593.9 1854.6 1875.8 1911.3 1937.7 1971.7 982.3 989.0 1012.3 1019.7 1035.4 19179.8 19222.1 19259.6 19415.2 19782.5 979.7 1020.6 1025.2 1026.9 1047.4 10299.2 10565.5 10571.4 10743.6 10818.5 499951.0 503862.0 508715.0 510612.0 510715.0 94132.1 95985.0 96941.0 100193.5 101855.0 967.0 987.2 1003.1 1005.7 1007.8 17053.4 17085.8 17315.9 17320.9 17531.6 42971.6 43230.1 43723.3 44696.3 44775.6 62815.4 63314.0 63692.4 64712.4 65011.7 7243.1 7564.1 7987.6 8026.3 8083.8 11940.9 14244.2 14464.9 14484.8 14603.4 12021.3 12165.8 12285.5 12513.9 12530.5 12423.3 12430.1 12471.9 12502.8 12683.1 11266.2 12204.1 12209.8 12504.1 12616.9 8698.4 8706.9 8761.2 8788.1 8948.4 8685.8 11374.8 11937.0 12400.9 12518.1 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | [#3] mootools.html Cycles:180 Average:5931.83 Median:2436.18 stddev:3467.90 (142.3%) stddev-sans-first:3461.46 20:37:36 INFO - PROCESS | 5852 | Values: 1475.5 1506.0 1622.5 1760.7 1766.8 7724.2 8741.4 8852.6 9210.0 9263.4 8800.6 9105.1 9136.8 9166.2 9175.5 2340.5 2375.7 2376.3 2377.4 2378.8 2343.7 2355.6 2370.9 2379.4 2381.4 2320.5 2329.5 2335.4 2354.6 2366.2 2253.6 2254.9 2262.2 2263.1 2279.3 2220.4 2224.5 2229.6 2229.8 2240.7 9193.1 9276.4 9314.7 9335.4 9342.5 5253.3 5375.1 5399.0 5410.8 5411.1 3365.5 3409.8 3496.3 3511.3 3521.6 1106.7 1126.2 1142.7 1163.2 1166.0 12708.2 12744.1 12745.4 12777.3 12841.6 4430.7 4549.4 4621.9 4728.9 4735.4 10698.6 10757.5 10766.4 10774.1 10778.8 5357.7 5377.7 5378.5 5379.0 5386.3 4381.6 4810.3 4943.5 4991.8 4995.9 3963.9 4002.6 4041.2 4069.5 4109.5 1236.3 1253.5 1261.9 1267.0 1271.3 824.8 931.3 988.8 996.0 1013.5 5833.7 5957.9 5995.7 6069.2 6187.5 434.6 434.8 440.9 441.7 463.8 3988.8 4124.4 4143.6 4160.5 4164.0 10907.3 11096.3 11236.1 11316.3 11380.7 11263.7 11300.7 11329.6 11358.7 11365.5 8392.5 8497.9 8559.9 8663.8 8711.7 5881.9 5922.2 6031.4 6065.3 6101.7 10421.3 10489.0 10541.1 10566.9 10618.4 10518.3 10635.0 10662.9 10783.5 10815.1 7371.7 7810.9 8071.5 8127.7 8210.8 8916.6 8950.1 8974.0 9000.4 9011.5 7609.9 7807.2 7840.8 7929.2 7960.7 7936.2 7959.0 8067.7 8112.5 8219.2 6548.4 6706.5 6755.5 6801.5 6817.7 5164.6 5200.3 5201.8 5209.9 5248.9 5053.4 5069.3 5099.3 5131.1 5196.0 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | [#4] prototype.html Cycles:180 Average:4904.64 Median:5680.66 stddev:1470.98 (25.9%) stddev-sans-first:1434.28 20:37:36 INFO - PROCESS | 5852 | Values: 318.8 320.1 323.7 327.8 329.9 5557.4 5613.8 5632.2 5638.4 5650.8 5548.3 5557.8 5574.3 5577.4 5612.7 4090.7 4188.6 4290.4 4301.3 4312.3 4267.2 4294.4 4299.5 4316.6 4323.8 4253.4 4286.2 4286.7 4291.9 4307.4 3991.3 4238.4 4239.0 4248.0 4313.8 3679.8 3710.5 3718.7 3720.9 3721.7 5421.2 5435.9 5444.3 5454.0 5500.2 4641.6 4858.5 4874.3 4894.0 4921.8 5781.5 5805.4 5808.8 5821.6 5829.6 4056.5 4074.7 4079.7 4083.0 4085.0 5859.4 6065.8 6070.9 6076.7 6096.7 4157.6 4171.1 4177.1 4184.5 4186.4 4215.8 4219.0 4221.9 4225.1 4280.9 4761.2 4879.8 4884.5 4926.9 4964.4 5861.7 5876.5 5888.4 5910.7 5928.6 1465.8 1467.9 1468.0 1477.1 1479.3 924.7 935.9 955.3 985.7 993.2 5641.2 5673.6 5687.7 5688.3 5688.6 5908.1 5928.6 5968.6 5977.7 6052.6 5467.4 5726.0 5759.4 5760.0 5787.8 3202.4 3202.8 3214.3 3214.5 3216.1 6039.7 6099.0 6189.8 6194.1 6224.0 6147.2 6164.4 6168.0 6174.8 6177.7 6079.8 6205.6 6207.3 6219.5 6220.1 5924.9 5981.5 5994.7 6006.3 6007.4 5927.3 5931.0 5940.4 5940.9 5980.2 5976.3 6136.2 6191.4 6231.9 6257.7 4155.6 4160.3 4175.9 4179.3 4186.7 5778.8 5804.2 6015.0 6022.9 6035.6 5875.2 5877.6 5891.8 5913.2 5916.3 5852.7 5855.5 5856.8 5869.9 5889.2 5594.4 5829.1 5875.6 5876.3 5881.2 5903.6 5933.0 5938.9 5947.2 5955.9 5649.5 5672.6 5778.6 5787.5 5802.0 20:37:36 INFO - PROCESS | 5852 | 20:37:36 INFO - PROCESS | 5852 | [#5] yui.html Cycles:180 Average:20255.28 Median:3928.72 stddev:27969.17 (711.9%) stddev-sans-first:28009.16 20:37:36 INFO - PROCESS | 5852 | Values: 718.0 786.0 789.8 797.3 850.3 15591.2 16566.4 16569.9 16686.7 16691.2 14863.4 14971.0 14983.7 15000.5 15005.8 628.7 758.3 776.0 781.1 781.7 781.3 784.9 785.8 787.9 788.4 825.3 826.6 833.9 836.7 837.0 814.2 820.3 822.9 823.0 825.0 602.4 604.6 607.8 607.9 608.2 14216.6 14256.5 14258.4 14296.6 14297.1 15569.7 15745.9 15914.9 15987.6 16343.8 12693.0 12772.8 12930.5 13006.0 13082.7 3838.6 3840.7 3886.6 3894.9 3962.6 72133.6 72364.0 73116.0 73908.0 75797.6 11612.7 11709.9 11731.8 11847.5 11870.4 21804.7 22554.4 22625.0 22663.0 22697.2 7948.4 8126.5 8272.5 8379.1 8528.5 4897.1 5018.2 5042.4 5048.6 5227.0 3472.4 3603.8 3614.8 3615.3 3617.1 582.3 593.4 595.3 602.4 612.9 667.8 673.4 677.9 679.8 690.3 9375.2 9529.2 9551.4 9632.0 10078.9 596.8 670.5 692.9 693.6 710.1 4598.7 4667.6 4721.3 4728.3 4765.0 68113.3 79938.6 113568.4 115043.4 115944.0 99266.5 99527.5 100730.5 100918.0 102489.5 54765.7 62824.7 81525.0 84447.6 84623.6 9935.7 10045.2 10078.6 10718.4 11050.5 37742.8 51392.2 53832.7 53849.7 54562.5 56802.0 75477.6 76705.2 78412.6 80049.2 12445.0 12657.5 13594.7 13849.9 13858.4 15548.5 16283.7 16474.2 17105.7 17139.0 14669.4 14920.0 15636.8 15684.5 16253.3 15205.1 15224.0 15434.4 15476.4 15533.5 12988.1 13682.7 14073.7 14514.4 16065.0 11999.2 12015.5 12148.6 12187.8 12505.9 10866.7 11166.5 11787.9 11860.5 11861.1 20:37:36 INFO - PROCESS | 5852 | -------- Summary: end -------- 20:37:36 INFO - PROCESS | 5852 | 20:37:37 INFO - TEST-INFO | 5852: exit 0 20:37:37 INFO - TEST-OK | dromaeo_css | took 1110196ms 20:37:37 INFO - TEST-START | kraken 20:37:37 INFO - operating with platform_type : linux_ 20:37:37 INFO - Initialising browser for kraken test... 20:37:37 INFO - TEST-INFO | started process 6099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp85OXX1/profile http://localhost:56553/getInfo.html) 20:37:42 INFO - PROCESS | 6099 | __metrics Screen width/height:1600/1200 20:37:42 INFO - PROCESS | 6099 | colorDepth:24 20:37:42 INFO - PROCESS | 6099 | Browser inner width/height: 1024/697 20:37:42 INFO - PROCESS | 6099 | __metrics 20:37:42 ERROR - PROCESS | 6099 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 20:37:43 INFO - TEST-INFO | 6099: exit 0 20:37:43 INFO - Browser initialized. 20:37:43 INFO - Running cycle 1/1 for kraken test... 20:37:43 INFO - TEST-INFO | started process 6224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp85OXX1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:55 INFO - PROCESS | 6224 | RSS: Main: 167129088 20:37:55 INFO - PROCESS | 6224 | 20:37:57 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56553/tests/kraken/driver.html?testName=audio-beat-detection) 20:37:58 INFO - PROCESS | 6224 | RSS: Main: 172445696 20:37:58 INFO - PROCESS | 6224 | 20:38:01 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56553/tests/kraken/driver.html?testName=audio-dft) 20:38:02 INFO - PROCESS | 6224 | RSS: Main: 172089344 20:38:02 INFO - PROCESS | 6224 | 20:38:04 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56553/tests/kraken/driver.html?testName=audio-fft) 20:38:05 INFO - PROCESS | 6224 | RSS: Main: 167268352 20:38:05 INFO - PROCESS | 6224 | 20:38:07 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56553/tests/kraken/driver.html?testName=audio-oscillator) 20:38:08 INFO - PROCESS | 6224 | RSS: Main: 167542784 20:38:08 INFO - PROCESS | 6224 | 20:38:10 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:38:11 INFO - PROCESS | 6224 | RSS: Main: 168361984 20:38:11 INFO - PROCESS | 6224 | 20:38:14 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56553/tests/kraken/driver.html?testName=imaging-darkroom) 20:38:14 INFO - PROCESS | 6224 | RSS: Main: 168251392 20:38:14 INFO - PROCESS | 6224 | 20:38:18 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56553/tests/kraken/driver.html?testName=imaging-desaturate) 20:38:18 INFO - PROCESS | 6224 | RSS: Main: 166010880 20:38:18 INFO - PROCESS | 6224 | 20:38:21 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56553/tests/kraken/driver.html?testName=json-parse-financial) 20:38:22 INFO - PROCESS | 6224 | RSS: Main: 167583744 20:38:22 INFO - PROCESS | 6224 | 20:38:23 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:38:24 INFO - PROCESS | 6224 | RSS: Main: 167575552 20:38:24 INFO - PROCESS | 6224 | 20:38:26 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:38:26 INFO - PROCESS | 6224 | RSS: Main: 168263680 20:38:26 INFO - PROCESS | 6224 | 20:38:29 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:38:29 INFO - PROCESS | 6224 | RSS: Main: 168611840 20:38:29 INFO - PROCESS | 6224 | 20:38:32 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:38:32 INFO - PROCESS | 6224 | RSS: Main: 168812544 20:38:32 INFO - PROCESS | 6224 | 20:38:35 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:38:36 INFO - PROCESS | 6224 | RSS: Main: 168566784 20:38:36 INFO - PROCESS | 6224 | 20:38:37 INFO - PROCESS | 6224 | Cycle 1(1): loaded http://localhost:56553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56553/tests/kraken/driver.html?testName=ai-astar) 20:38:38 INFO - PROCESS | 6224 | RSS: Main: 169099264 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | __start_tp_report 20:38:38 INFO - PROCESS | 6224 | _x_x_mozilla_page_load 20:38:38 INFO - PROCESS | 6224 | _x_x_mozilla_page_load_details 20:38:38 INFO - PROCESS | 6224 | |i|pagename|runs| 20:38:38 INFO - PROCESS | 6224 | |0;ai-astar;102;111;105;110;112;111;111;109;110;110 20:38:38 INFO - PROCESS | 6224 | |1;audio-beat-detection;151;120;146;177;124;157;147;119;173;117 20:38:38 INFO - PROCESS | 6224 | |2;audio-dft;162;162;161;161;163;162;167;165;161;161 20:38:38 INFO - PROCESS | 6224 | |3;audio-fft;74;77;76;151;77;76;76;75;167;76 20:38:38 INFO - PROCESS | 6224 | |4;audio-oscillator;84;84;143;85;85;85;143;85;84;142 20:38:38 INFO - PROCESS | 6224 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;118;119;118 20:38:38 INFO - PROCESS | 6224 | |6;imaging-darkroom;148;147;146;147;147;147;147;148;147;146 20:38:38 INFO - PROCESS | 6224 | |7;imaging-desaturate;96;96;99;96;95;96;95;95;95;96 20:38:38 INFO - PROCESS | 6224 | |8;json-parse-financial;55;56;58;59;61;54;56;56;56;55 20:38:38 INFO - PROCESS | 6224 | |9;json-stringify-tinderbox;61;60;60;61;60;61;60;61;60;61 20:38:38 INFO - PROCESS | 6224 | |10;stanford-crypto-aes;77;75;76;75;75;78;85;82;82;76 20:38:38 INFO - PROCESS | 6224 | |11;stanford-crypto-ccm;128;126;122;132;120;132;137;143;156;130 20:38:38 INFO - PROCESS | 6224 | |12;stanford-crypto-pbkdf2;157;159;157;159;157;158;163;158;158;158 20:38:38 INFO - PROCESS | 6224 | |13;stanford-crypto-sha256-iterative;64;67;64;64;66;67;66;63;63;69 20:38:38 INFO - PROCESS | 6224 | __end_tp_report 20:38:38 INFO - PROCESS | 6224 | __start_cc_report 20:38:38 INFO - PROCESS | 6224 | _x_x_mozilla_cycle_collect,929 20:38:38 INFO - PROCESS | 6224 | __end_cc_report 20:38:38 INFO - PROCESS | 6224 | __startTimestamp1468381118222__endTimestamp 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | ------- Summary: start ------- 20:38:38 INFO - PROCESS | 6224 | Number of tests: 14 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.14 (2.8%) stddev-sans-first:2.03 20:38:38 INFO - PROCESS | 6224 | Values: 102.0 111.0 105.0 110.0 112.0 111.0 111.0 109.0 110.0 110.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.00 stddev:22.32 (15.0%) stddev-sans-first:23.49 20:38:38 INFO - PROCESS | 6224 | Values: 151.0 120.0 146.0 177.0 124.0 157.0 147.0 119.0 173.0 117.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.01 (1.2%) stddev-sans-first:2.13 20:38:38 INFO - PROCESS | 6224 | Values: 162.0 162.0 161.0 161.0 163.0 162.0 167.0 165.0 161.0 161.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:35.26 (46.4%) stddev-sans-first:36.76 20:38:38 INFO - PROCESS | 6224 | Values: 74.0 77.0 76.0 151.0 77.0 76.0 76.0 75.0 167.0 76.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.50 stddev:28.07 (33.2%) stddev-sans-first:29.00 20:38:38 INFO - PROCESS | 6224 | Values: 84.0 84.0 143.0 85.0 85.0 85.0 143.0 85.0 84.0 142.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:38:38 INFO - PROCESS | 6224 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 119.0 118.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 20:38:38 INFO - PROCESS | 6224 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 147.0 146.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:1.27 20:38:38 INFO - PROCESS | 6224 | Values: 96.0 96.0 99.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.12 (3.8%) stddev-sans-first:2.17 20:38:38 INFO - PROCESS | 6224 | Values: 55.0 56.0 58.0 59.0 61.0 54.0 56.0 56.0 56.0 55.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 20:38:38 INFO - PROCESS | 6224 | Values: 61.0 60.0 60.0 61.0 60.0 61.0 60.0 61.0 60.0 61.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:3.60 (4.7%) stddev-sans-first:3.80 20:38:38 INFO - PROCESS | 6224 | Values: 77.0 75.0 76.0 75.0 75.0 78.0 85.0 82.0 82.0 76.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.00 stddev:10.64 (8.1%) stddev-sans-first:11.15 20:38:38 INFO - PROCESS | 6224 | Values: 128.0 126.0 122.0 132.0 120.0 132.0 137.0 143.0 156.0 130.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.00 stddev:1.78 (1.1%) stddev-sans-first:1.81 20:38:38 INFO - PROCESS | 6224 | Values: 157.0 159.0 157.0 159.0 157.0 158.0 163.0 158.0 158.0 158.0 20:38:38 INFO - PROCESS | 6224 | 20:38:38 INFO - PROCESS | 6224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:2.00 (3.0%) stddev-sans-first:2.07 20:38:38 INFO - PROCESS | 6224 | Values: 64.0 67.0 64.0 64.0 66.0 67.0 66.0 63.0 63.0 69.0 20:38:38 INFO - PROCESS | 6224 | -------- Summary: end -------- 20:38:38 INFO - PROCESS | 6224 | 20:38:39 INFO - TEST-INFO | 6224: exit 0 20:38:39 INFO - TEST-OK | kraken | took 61632ms 20:38:39 INFO - SUITE-END | took 1171s 20:38:39 INFO - Completed test suite (00:19:32) 20:38:39 INFO - javascript benchmark 20:38:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7362.275951271626, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.500239961606, 3145.6067991501063, 3152.196189971557, 3154.637216720078, 3168.002079345006, 5495.230667706519, 5590.909772594346, 5600.663960162393, 5621.915671264929, 5630.268065151535, 5407.432219616942, 5459.645123066998, 5501.972490137554, 5537.529310008654, 5572.498475137237, 4989.101961646902, 5010.72441015744, 5117.104506711329, 5162.251473536335, 5211.739413029352, 81.88221351325878, 5023.271625614284, 5111.182210846266, 5131.692098474085, 5152.92270615941, 5020.121478741242, 5023.6985780853265, 5033.974830125862, 5038.949610503884, 5082.872928176806, 4947.554720075174, 5023.32185155003, 5049.040682270357, 5054.1407960646775, 5067.695938243681, 4920.3357546731095, 4988.925166122511, 4991.0, 5005.924911126336, 5059.974700126476, 5464.535514481274, 5479.0, 5503.862403439946, 5520.089185284423, 5571.498565129158, 5773.2494775679315, 5841.707914604252, 5864.76540938362, 5906.852328691817, 5913.497352725023, 5918.053111502182, 5951.3751056139345, 5961.195238642815, 5984.132300816357, 5989.730462129215, 5538.086215774432, 5543.1408131739245, 5546.168074788774, 5554.222408862722, 5560.193771903092, 5959.702014899238, 6048.183495228176, 6060.636361818305, 6075.27096748393, 6118.694065296718, 5877.764889404461, 5883.441073098049, 5889.146073819358, 5892.970535147297, 5895.35151133375, 5969.552283578662, 5970.164177015221, 5984.222051133324, 5995.340512543617, 5997.580169388189, 5749.482546570745, 5835.679037652885, 5863.765449382062, 5903.763849445974, 5912.526997840162, 5692.060809966392, 5816.360200377955, 5887.676177810176, 5895.793647222326, 5896.1450589664255, 4513.751743654065, 4534.161180181677, 4537.636989040869, 4538.387317712132, 4582.862514124582, 3971.3447281198855, 3984.2230765000545, 4007.218592374459, 4037.0, 4048.1701251243426, 5747.655140691572, 5749.35786392685, 5749.626274292157, 5752.108423194411, 5752.539796816244, 5764.682942438206, 5966.701664916737, 6040.033594624839, 6040.848978775566, 6041.305249896318, 5642.943570564242, 5654.236678048411, 5663.292088488939, 5664.716764161775, 5709.885802283931, 5126.15418455958, 5141.614378921521, 5143.819966301162, 5147.871303217449, 5192.117340052125, 6045.33501314855, 6098.939010609926, 6165.383461653889, 6168.1056246844855, 6173.444390004921, 5927.585069045212, 6000.8499787503915, 6003.189569408249, 6016.067509536029, 6054.061620448838, 6180.938190618216, 6186.257649082139, 6193.783217587363, 6197.5351848610635, 6201.96899015502, 5741.081426971665, 5777.422257774357, 5810.564207684356, 5913.940860591339, 5920.703964801829, 5898.8230353089475, 5973.761049557969, 5993.760249589967, 6015.0676645120075, 6066.696665166635, 5730.426957304237, 5784.0, 5793.565482588739, 5823.213866128019, 5844.795432160024, 5604.85987850307, 5704.771809127755, 5742.741576629145, 5801.361850196559, 5805.622634528742, 5657.038303488334, 5697.173909783141, 5705.429457054427, 5796.681182535001, 5803.9419605803405, 5744.684042377709, 5779.2775903012125, 5827.970860145672, 5843.065109582446, 5864.0, 5682.176084467646, 5740.024195886625, 5744.540436764965, 5747.885042299215, 5772.509336706259], "value": 5435.66948294655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.3470281460251, 594.2868557730724, 598.6856900127435, 614.2383444528784, 634.235745926159, 39246.60753392465, 42632.14735705284, 43019.0, 43263.0, 43275.350869736976, 43106.137877242436, 43753.78123109388, 43872.3419148713, 43932.78033609827, 43936.780316098375, 8917.464952102879, 9040.457572545669, 9041.773955651128, 9053.230475409599, 9069.863952040725, 8797.384183107186, 8885.0, 8924.687635932743, 8940.64237430502, 8956.731298061068, 8944.418612790148, 8951.194392504673, 8952.373333866632, 9011.459312441242, 9020.23328017116, 8867.77830554238, 8927.241184499293, 8972.551372431351, 8975.775605609846, 8979.775505612346, 8841.469511829311, 8935.0, 8969.237614802749, 8987.46075235488, 8993.325500587482, 41636.58363416357, 41730.582694172976, 41792.79103604493, 41905.79047104775, 42227.36658950118, 3667.9266414671824, 3686.096906257984, 3687.907802304937, 3776.4712940188397, 4088.366303223005, 33489.16277093068, 33668.32663346744, 33754.6624533754, 34163.487547686804, 34766.652333476595, 4425.181341451842, 4493.326001099861, 4506.828224661579, 4572.634189264851, 4575.382323386333, 241031.0, 242019.0, 242181.0, 242242.0, 242891.0, 52491.21263181055, 60979.39020609737, 63152.0, 64760.35239647637, 65366.67316663386, 64049.67975160188, 64335.0, 64341.0, 64359.0, 64506.677466613306, 17534.298628054734, 17673.823261767477, 17685.115744212737, 17697.911510442624, 17724.20241089154, 13488.93255533716, 13508.0, 13516.189028658311, 13597.252151131584, 13602.251876146907, 18245.178966946518, 18319.450416487525, 18492.763766340835, 18523.72214416785, 18554.257829686932, 5782.421757824184, 5817.7091145442555, 5959.791407300723, 5988.9101663475085, 6019.578629495981, 956.789506308611, 989.678354534779, 1009.5608410341379, 1033.617561502249, 1121.315997241682, 31816.20459488485, 31944.84027579894, 32048.83975580154, 32499.18752031218, 32591.0, 1063.9042486176281, 1097.6706987903597, 1185.9703507412385, 1200.4477940147456, 1225.1607648760628, 17016.0, 17031.0, 17186.91406542959, 17464.65070698579, 17517.516026357254, 511860.0, 513252.0, 514084.0, 516933.0, 517045.0, 59222.11166832501, 59282.40717592855, 59478.40521594815, 59631.70184149052, 59702.10446843301, 1269.650846017334, 1313.3958379145508, 1334.7063645997864, 1350.2641060621984, 1360.2586590308306, 31356.372872542877, 31605.20986975344, 31673.683263167073, 31998.52002219922, 32488.0, 50551.241731374794, 50906.0, 51025.0, 51067.0, 51074.74462627663, 438956.0, 439421.0, 441481.0, 442899.0, 443302.0, 28413.147605571867, 28516.857415713617, 28847.85576072106, 28852.855735721187, 28896.566551501324, 50676.74661626668, 50744.49255507398, 50934.235986460975, 51041.74479127729, 51494.742526287126, 43395.0, 43448.78275608602, 44285.55714442943, 44289.77855110704, 44800.77599612111, 41893.371599426646, 42143.36784948167, 42815.571844281156, 43201.91995200145, 44428.333574995755, 41994.58005419907, 42647.57352426436, 43238.351424729284, 43642.0, 45888.31167532423, 36691.08272293214, 37724.62275377211, 38434.80782596069, 38554.421683674205, 38901.0, 29237.122886313446, 29386.706132939253, 29412.11763647094, 29723.0, 29930.700692992792], "value": 20207.814022223592, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.31777339794405, 385.59705108161967, 390.4982098004065, 393.66145115200925, 409.78281510799286, 14340.498082567112, 18743.3439829606, 19708.70436943447, 20567.485812854666, 20742.170313187475, 18923.43229703111, 19314.806851931477, 19576.412707618758, 19606.62753607248, 19636.527260455452, 5731.828045158631, 5820.738066786994, 5903.911441328383, 5949.286085669725, 5969.552283578727, 5224.346956630421, 5548.167774833767, 5856.033754430535, 5877.764889404419, 5915.911261331062, 5591.189277554752, 5598.048331783607, 5601.747921343549, 5618.325800903876, 5626.381098079208, 5531.778728850841, 5595.552355811526, 5614.943850561483, 5625.662460252398, 5650.463205995424, 5402.864928376783, 5435.10320797068, 5478.534324582415, 5502.779888804443, 5506.724663766836, 20399.184032638826, 22555.436114097116, 23085.884570577207, 23531.647025294635, 23572.88213558921, 2285.6571514272828, 2293.736220334666, 2374.8931298091456, 2410.927672169838, 2475.4306509502735, 9571.569279382375, 9725.56234969421, 9836.803263934753, 9916.95041524795, 10320.0, 1962.1072412052624, 2032.6036422897541, 2039.4595432210476, 2048.95902081959, 2049.7950204979534, 84590.57704711499, 86812.0, 87730.0, 88098.55950720205, 88695.0, 10476.0, 10639.414832184304, 10738.94630526858, 10864.891351086546, 10941.4529273536, 14654.633634159018, 14761.409543618134, 14823.110613363233, 14903.403863845542, 14909.179995100374, 7985.760427187078, 8168.142345053802, 8196.30331421824, 8209.507429554245, 8386.287165590871, 7993.400494962901, 8162.451725426685, 8167.591620418955, 8181.754547363588, 8434.493930364199, 4505.324201369821, 4508.458984921765, 4541.863744087683, 4557.863264102082, 4593.908121837545, 1854.5827188882392, 1875.7936626971023, 1911.3405874973112, 1937.6996565532365, 1971.654960381956, 982.3074732313702, 989.0307498651218, 1012.3015119567475, 1019.7246743379246, 1035.404642330663, 19179.80820191808, 19222.135003924857, 19259.61480770377, 19415.2233910642, 19782.50543736418, 979.7207795778169, 1020.5764607687727, 1025.195221750922, 1026.9383836969805, 1047.3768107975743, 10299.227557933185, 10565.471726413649, 10571.36571805694, 10743.623973160902, 10818.459077046116, 499951.0, 503862.0, 508715.0, 510612.0, 510715.0, 94132.0586794137, 95985.0, 96941.03058969461, 100193.49903250438, 101855.0, 966.9661561845443, 987.2496902354262, 1003.0821798054844, 1005.7435353984833, 1007.773251018515, 17053.403130890358, 17085.829141708426, 17315.91342043332, 17320.874143180652, 17531.649367012844, 42971.57028429801, 43230.13539729125, 43723.34414983841, 44696.32955505605, 44775.552244478444, 62815.371846280956, 63314.0, 63692.363076368645, 64712.352876470635, 65011.67494162688, 7243.130824300907, 7564.130125035691, 7987.560684162427, 8026.317762990211, 8083.797905052421, 11940.940295298467, 14244.216568088854, 14464.927675361556, 14484.782728259295, 14603.415863365346, 12021.338826364634, 12165.756684866075, 12285.508579656713, 12513.93743031279, 12530.49878004906, 12423.31671758062, 12430.12989090755, 12471.875281247434, 12502.812457813323, 12683.11218214716, 11266.211365204357, 12204.145709800583, 12209.755804883675, 12504.124711270124, 12616.87383126157, 8698.434601750865, 8706.91293087061, 8761.167689069529, 8788.121187881416, 8948.373613846969, 8685.826283474169, 11374.829377559177, 11937.0, 12400.875991239973, 12518.12373133872], "value": 9298.967458258072, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.52783109405, 1506.0436622744555, 1622.5294664547282, 1760.6918789211884, 1766.849817765489, 7724.150343462229, 8741.388102832805, 8852.645894164241, 9209.953950230249, 9263.39787913786, 8800.647974081028, 9105.135012173832, 9136.771580710485, 9166.175044246016, 9175.54122293886, 2340.4733934864603, 2375.714914210297, 2376.275236053003, 2377.3699969508093, 2378.7859092681656, 2343.6836027136287, 2355.611324131516, 2370.8577485350934, 2379.393254720044, 2381.404648837791, 2320.466292752668, 2329.487512747193, 2335.3577766114367, 2354.6114891043044, 2366.171839856054, 2253.5718213539376, 2254.8534345267585, 2262.2195342606856, 2263.0834512022657, 2279.2706333973133, 2220.4004918671867, 2224.4994876152896, 2229.6209644360497, 2229.8104661103825, 2240.6863039174527, 9193.126652967958, 9276.350655454122, 9314.72055838326, 9335.393199442015, 9342.532873356373, 5253.3170687810725, 5375.059364611217, 5399.0, 5410.756515956791, 5411.134218525017, 3365.4615261558033, 3409.7613167078316, 3496.283261931298, 3511.2977404519197, 3521.559805024372, 1106.7399161197113, 1126.1610100475116, 1142.731458107344, 1163.162522983459, 1166.0, 12708.173968692005, 12744.10791244604, 12745.426455809511, 12777.29724865132, 12841.614751557374, 4430.667699922518, 4549.385832912581, 4621.907561848744, 4728.905421891543, 4735.384400027974, 10698.572057117784, 10757.515911783988, 10766.354018758899, 10774.084202842689, 10778.78442431147, 5357.705326207096, 5377.650452720561, 5378.515933565998, 5379.031774280589, 5386.299781028441, 4381.6494680425485, 4810.278458231293, 4943.456219815817, 4991.750412479434, 4995.850124496271, 3963.8810835674976, 4002.5597184309704, 4041.211963667057, 4069.5320038195396, 4109.465769450012, 1236.313845815563, 1253.5361916091106, 1261.9053570982212, 1266.9873301266869, 1271.2690203133236, 824.8309096635176, 931.2736065868634, 988.7528117970508, 995.9601615935281, 1013.4932533733133, 5833.7374818133285, 5957.851053723692, 5995.730192141277, 6069.180660610849, 6187.535934804908, 434.6457637025877, 434.7521912509839, 440.8677396781017, 441.7018512504111, 463.84693051292993, 3988.840446382112, 4124.4019617155345, 4143.585641435892, 4160.45914031174, 4164.000639846476, 10907.291026083438, 11096.278741881752, 11236.101111911028, 11316.321020738782, 11380.658580242605, 11263.66209013731, 11300.71748206285, 11329.603463878724, 11358.659240222807, 11365.545378184945, 8392.538410387488, 8497.872531912026, 8559.914400856036, 8663.826723465621, 8711.651533938699, 5881.852953676193, 5922.170896074467, 6031.36670649593, 6065.272167339947, 6101.6644084574, 10421.270511064457, 10489.0, 10541.051305382553, 10566.943305669372, 10618.415987120783, 10518.263721539419, 10635.0, 10662.946685266834, 10783.460826958777, 10815.080718138732, 7371.668274927534, 7810.9218907812465, 8071.515709057476, 8127.715529956423, 8210.753677389688, 8916.55417229149, 8950.060243674321, 8973.955130224307, 9000.369974102012, 9011.459312441275, 7609.923900761143, 7807.219278072147, 7840.843183136191, 7929.246721561442, 7960.681572737258, 7936.206379362017, 7959.0, 8067.677292908453, 8112.513249205066, 8219.178082191733, 6548.410643042149, 6706.530542861953, 6755.459563234831, 6801.455883529206, 6817.659117044029, 5164.612654050886, 5200.349956255468, 5201.817936372209, 5209.895802083861, 5248.895022099613, 5053.397500287429, 5069.3156423883775, 5099.260607212008, 5131.127708289674, 5196.0], "value": 4622.81933734222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.83898631191244, 320.0941336019066, 323.6747069195458, 327.8196991654589, 329.8598095809281, 5557.360903496099, 5613.831585052445, 5632.239647647566, 5638.419603551738, 5650.830475085743, 5548.278723765905, 5557.805476808313, 5574.275344205248, 5577.358603760569, 5612.69130197839, 4090.6522945549664, 4188.560201178878, 4290.399344091829, 4301.29028710264, 4312.28847240205, 4267.1892340455215, 4294.441722576061, 4299.462567179103, 4316.589923957219, 4323.762193079379, 4253.44705188325, 4286.185624731306, 4286.728034141895, 4291.8712438626735, 4307.375430562566, 3991.301522233612, 4238.4490016298, 4239.0, 4247.957520424818, 4313.849015284466, 3679.8344074516713, 3710.4619830124752, 3718.72109591779, 3720.8511659533588, 3721.7160079772434, 5421.213923981, 5435.858469721364, 5444.265024221759, 5454.018276710191, 5500.22996780451, 4641.559051890065, 4858.5384388483035, 4874.341963834872, 4893.95106048942, 4921.80312787488, 5781.4507621775865, 5805.390434004453, 5808.796692115756, 5821.592488525805, 5829.5919285650025, 4056.5132184137797, 4074.7351422157467, 4079.653229475498, 4083.0, 4085.0400155963325, 5859.4140585941495, 6065.756519913407, 6070.908936365958, 6076.726547305382, 6096.664683442409, 4157.64660003897, 4171.124063946544, 4177.060161463646, 4184.5187803403, 4186.35111557709, 4215.768132752667, 4218.957810421918, 4221.894452638709, 4225.070484493406, 4280.935785963213, 4761.166950723996, 4879.756012199447, 4884.511548845158, 4926.876828079255, 4964.35463389757, 5861.70691465425, 5876.529877609781, 5888.381719919433, 5910.674912879746, 5928.584999050025, 1465.7874608181753, 1467.8917417350046, 1467.992660036693, 1477.1211129378003, 1479.2677624575688, 924.7040946897063, 935.864299676543, 955.2835373469898, 985.7338518599938, 993.2451336983944, 5641.182028605829, 5673.6028478006965, 5687.7156142192725, 5688.265079150816, 5688.606291458619, 5908.134554740947, 5928.584999050111, 5968.641881487125, 5977.701114944235, 6052.576319657582, 5467.398586155519, 5725.997950358671, 5759.424057594207, 5759.971200143972, 5787.797427090116, 3202.4235637585457, 3202.8309666971854, 3214.2928555717704, 3214.4856822908223, 3216.1477208539754, 6039.667818270037, 6098.963176260047, 6189.752409903554, 6194.101855230966, 6224.0, 6147.200863887666, 6164.4143806338325, 6167.951448253808, 6174.753009879644, 6177.69111544421, 6079.848003799941, 6205.596636218722, 6207.317195108534, 6219.502439804804, 6220.050268079802, 5924.851878703067, 5981.521478281814, 5994.730237139426, 6006.3182308953565, 6007.429294217042, 5927.2590926134235, 5930.970345148246, 5940.405959404025, 5940.851478713067, 5980.192673988956, 5976.3127240366175, 6136.23297087864, 6191.4118158774845, 6231.937680623136, 6257.749690012531, 4155.605217504332, 4160.292750232407, 4175.874723758292, 4179.286492538166, 4186.748795072305, 5778.768849245983, 5804.171685918922, 6015.0, 6022.90965635507, 6035.6076855004285, 5875.236219291465, 5877.647341159544, 5891.764329426775, 5913.231279933581, 5916.349201587908, 5852.736626851717, 5855.502282306052, 5856.795012174553, 5869.911951320819, 5889.234399528034, 5594.41258667834, 5829.09649004405, 5875.6474611523445, 5876.324222714443, 5881.206037185097, 5903.586748927705, 5933.0, 5938.940610593839, 5947.197128387612, 5955.880882382415, 5649.519790817826, 5672.574556908331, 5778.595498315078, 5787.479126878601, 5801.998310582842], "value": 4426.24169932949, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.9892301615477, 785.9646315915783, 789.7946533901188, 797.2904115337349, 850.2517784349772, 15591.220438978049, 16566.420175293853, 16569.917150414247, 16686.66626667466, 16691.248893799777, 14863.405463781435, 14971.0, 14983.700325993474, 15000.549983500485, 15005.774913376308, 628.6699482771547, 758.2872100225798, 775.9650815713306, 781.0744268042359, 781.6756046240803, 781.3358645151604, 784.925432083954, 785.8428314337127, 787.9290863822255, 788.3732432716005, 825.3026192867018, 826.5701835045803, 833.8790875323075, 836.6736972580699, 837.0374069819726, 814.1614137438389, 820.3437250199846, 822.8724547695117, 822.9917700822975, 825.0099880143821, 602.4066294699717, 604.6100265328838, 607.8176547035915, 607.9300880398722, 608.1850320570412, 14216.644583885382, 14256.501022464268, 14258.429662813474, 14296.642583935381, 14297.070690405195, 15569.688606227925, 15745.92127039369, 15914.920425397915, 15987.600309992227, 16343.754843677354, 12693.048021398432, 12772.808407873888, 12930.54743083997, 13006.0, 13082.672933176651, 3838.596947320519, 3840.6735427488697, 3886.5724770275247, 3894.863679771223, 3962.5839286874752, 72133.63933180353, 72364.0, 73116.0, 73908.0, 75797.62101189514, 11612.6516204514, 11709.941450292694, 11731.765364692828, 11847.526098955945, 11870.406479675981, 21804.672929906064, 22554.436139096655, 22624.98187581563, 22663.0, 22697.205597803997, 7948.443608947318, 8126.471779334324, 8272.462289951134, 8379.120192379834, 8528.53093079874, 4897.118518666674, 5018.247262910592, 5042.42012168598, 5048.646594738407, 5226.97386513065, 3472.409690352646, 3603.7567039371374, 3614.7831130132276, 3615.29501747162, 3617.113807117273, 582.2692520886261, 593.4214141212369, 595.3094410483818, 602.3885755957706, 612.8958077126899, 667.7796327212009, 673.4141297071579, 677.9389854912982, 679.7586856665812, 690.3338278561213, 9375.203107735919, 9529.190018848338, 9551.42691438516, 9631.991364490426, 10078.899211007943, 596.83885350955, 670.5105273150627, 692.944564434844, 693.6081114170578, 710.0662628643317, 4598.747068911242, 4667.6265898728025, 4721.268203428474, 4728.3143944127905, 4765.0, 68113.3188668107, 79938.6003069981, 113568.43215784033, 115043.42478287555, 115944.0, 99266.5036674812, 99527.50236248772, 100730.4963475178, 100918.0, 102489.48755256175, 54765.726171368886, 62824.68587657032, 81525.0, 84447.5777621108, 84623.5768821152, 9935.65225217114, 10045.246606504395, 10078.596856125967, 10718.35689858611, 11050.502727377449, 37742.8112859434, 51392.229116562536, 53832.73083634557, 53849.73075134599, 54562.454375457324, 56802.0, 75477.62261188879, 76705.2329476698, 78412.60793695995, 80049.19950800418, 12445.0, 12657.493700251887, 13594.728105438033, 13849.930750346184, 13858.4456621734, 15548.533543993699, 16283.674326513641, 16474.176291185155, 17105.657886841946, 17139.0, 14669.413223470941, 14920.0, 15636.843631563994, 15684.451044213398, 16253.268602912662, 15205.087694738351, 15224.0, 15434.382624694887, 15476.380944762084, 15533.533993980198, 12988.090833641554, 13682.726345472836, 14073.718525629634, 14514.419423222953, 16065.0, 11999.220050696676, 12015.519379225083, 12148.635540933432, 12187.75624487523, 12505.93747031259, 10866.67399978002, 11166.53609290246, 11787.941060294643, 11860.525578976743, 11861.110416718608], "value": 7618.687907697262, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 110.0, 112.0, 111.0, 111.0, 109.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 146.0, 177.0, 124.0, 157.0, 147.0, 119.0, 173.0, 117.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 163.0, 162.0, 167.0, 165.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 151.0, 77.0, 76.0, 76.0, 75.0, 167.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 85.0, 85.0, 85.0, 143.0, 85.0, 84.0, 142.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 99.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 58.0, 59.0, 61.0, 54.0, 56.0, 56.0, 56.0, 55.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 75.0, 75.0, 78.0, 85.0, 82.0, 82.0, 76.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 122.0, 132.0, 120.0, 132.0, 137.0, 143.0, 156.0, 130.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 157.0, 159.0, 157.0, 158.0, 163.0, 158.0, 158.0, 158.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 64.0, 66.0, 67.0, 66.0, 63.0, 63.0, 69.0], "value": 65.3, "unit": "score"}]}]} 20:38:39 INFO - Return code: 0 20:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:38:39 ERROR - # TBPL SUCCESS # 20:38:39 INFO - Running post-action listener: _resource_record_post_action 20:38:39 INFO - ##### 20:38:39 INFO - ##### Finished run-tests step (success) 20:38:39 INFO - ##### 20:38:39 INFO - Running post-run listener: _resource_record_post_run 20:38:39 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 299470848; Read time: 0; Write time: 272912 20:38:39 INFO - TinderboxPrint: CPU usage
13.2% 20:38:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:38:39 INFO - TinderboxPrint: I/O write bytes / time
299,470,848 / 272,912 20:38:39 INFO - TinderboxPrint: CPU idle
8,230.2 (86.7%) 20:38:39 INFO - TinderboxPrint: CPU user
1,204.0 (12.7%) 20:38:39 INFO - TinderboxPrint: Swap in / out
0 / 0 20:38:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5218304; Read time: 0; Write time: 552 20:38:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 294252544; Read time: 0; Write time: 272360 20:38:40 INFO - Running post-run listener: _upload_blobber_files 20:38:40 INFO - Blob upload gear active. 20:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:38:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:38:40 INFO - (blobuploader) - INFO - Open directory for files ... 20:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:41 INFO - (blobuploader) - INFO - Done attempting. 20:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:44 INFO - (blobuploader) - INFO - Done attempting. 20:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:45 INFO - (blobuploader) - INFO - Done attempting. 20:38:45 INFO - (blobuploader) - INFO - Iteration through files over. 20:38:45 INFO - Return code: 0 20:38:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:38:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:38:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/961c3f8123afb9a9a78d98c0259a277e84176fb52b5138485921ed220a78d5af067a9c08d5c6df21a91bc5d5dcdd099ab6ad798c4c9961512d31c4686341f6ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b838adea1deadd0f41c8a3a7a65f921f74a0c61107f6947f49759c6cbb38851e6ad64c47a86d2114bf5584dce86e057e77f94552c77529aa89b22560163144a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3711b4e2441d9387725e0fa1aac3d08e1a0004b04fe18762887b66578c14472398fc64c3699436cf9f40d13ba20af649574cb903047b8971be9a2f465dd2654"} 20:38:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:38:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:38:45 INFO - Contents: 20:38:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/961c3f8123afb9a9a78d98c0259a277e84176fb52b5138485921ed220a78d5af067a9c08d5c6df21a91bc5d5dcdd099ab6ad798c4c9961512d31c4686341f6ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b838adea1deadd0f41c8a3a7a65f921f74a0c61107f6947f49759c6cbb38851e6ad64c47a86d2114bf5584dce86e057e77f94552c77529aa89b22560163144a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3711b4e2441d9387725e0fa1aac3d08e1a0004b04fe18762887b66578c14472398fc64c3699436cf9f40d13ba20af649574cb903047b8971be9a2f465dd2654"} 20:38:45 INFO - Running post-run listener: copy_logs_to_upload_dir 20:38:45 INFO - Copying logs to upload dir... 20:38:45 INFO - mkdir: /builds/slave/test/build/upload/logs 20:38:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.464076 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-12 20:38:45.479379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:45.482716) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698 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/sha512/961c3f8123afb9a9a78d98c0259a277e84176fb52b5138485921ed220a78d5af067a9c08d5c6df21a91bc5d5dcdd099ab6ad798c4c9961512d31c4686341f6ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b838adea1deadd0f41c8a3a7a65f921f74a0c61107f6947f49759c6cbb38851e6ad64c47a86d2114bf5584dce86e057e77f94552c77529aa89b22560163144a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3711b4e2441d9387725e0fa1aac3d08e1a0004b04fe18762887b66578c14472398fc64c3699436cf9f40d13ba20af649574cb903047b8971be9a2f465dd2654"} build_url:https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/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/sha512/961c3f8123afb9a9a78d98c0259a277e84176fb52b5138485921ed220a78d5af067a9c08d5c6df21a91bc5d5dcdd099ab6ad798c4c9961512d31c4686341f6ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b838adea1deadd0f41c8a3a7a65f921f74a0c61107f6947f49759c6cbb38851e6ad64c47a86d2114bf5584dce86e057e77f94552c77529aa89b22560163144a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3711b4e2441d9387725e0fa1aac3d08e1a0004b04fe18762887b66578c14472398fc64c3699436cf9f40d13ba20af649574cb903047b8971be9a2f465dd2654"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:45.508795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:45.509141) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468379619.513021-1203134698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:38:45.594493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 20:38:45.595335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 20:38:45.596066) ========= ========= Total master_lag: 0.18 =========